builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-039 starttime: 1469028126.19 results: success (0) buildid: 20160720065019 builduid: 6fdafeb9ffd64a08803baab8d9a0451f revision: 76631f34f9bcfb8b9366200fc541f6d44a024ebb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 08:22:06.188147) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 08:22:06.188593) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 08:22:06.188860) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 08:22:06.200049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 08:22:06.200313) ========= 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=5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 08:22:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-07-20 08:22:06 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118886 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 08:22:06.330964) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 08:22:06.331280) ========= 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=5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021157 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 08:22:06.380831) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 08:22:06.381160) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 76631f34f9bcfb8b9366200fc541f6d44a024ebb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 76631f34f9bcfb8b9366200fc541f6d44a024ebb --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=5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 08:22:06,676 truncating revision to first 12 chars 2016-07-20 08:22:06,676 Setting DEBUG logging. 2016-07-20 08:22:06,676 attempt 1/10 2016-07-20 08:22:06,676 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/76631f34f9bc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 08:22:06,997 unpacking tar archive at: autoland-76631f34f9bc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.691396 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 08:22:07.086195) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 08:22:07.086521) ========= script_repo_revision: 76631f34f9bcfb8b9366200fc541f6d44a024ebb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 08:22:07.086894) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 08:22:07.087167) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 08:22:07.095727) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-07-20 08:22:07.096031) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:22:07 INFO - MultiFileLogger online at 20160720 08:22:07 in /builds/slave/test 08:22:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 08:22:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:22:07 INFO - {'append_to_log': False, 08:22:07 INFO - 'base_work_dir': '/builds/slave/test', 08:22:07 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 08:22:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:22:07 INFO - 'branch': 'Autoland-Non-PGO', 08:22:07 INFO - 'buildbot_json_path': 'buildprops.json', 08:22:07 INFO - 'config_files': ('talos/linux_config.py',), 08:22:07 INFO - 'default_actions': ('clobber', 08:22:07 INFO - 'read-buildbot-config', 08:22:07 INFO - 'download-and-extract', 08:22:07 INFO - 'populate-webroot', 08:22:07 INFO - 'create-virtualenv', 08:22:07 INFO - 'install', 08:22:07 INFO - 'run-tests'), 08:22:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:22:07 INFO - 'download_minidump_stackwalk': True, 08:22:07 INFO - 'download_symbols': 'ondemand', 08:22:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:22:07 INFO - 'tooltool.py': '/tools/tooltool.py', 08:22:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:22:07 INFO - '/tools/misc-python/virtualenv.py')}, 08:22:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:22:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:22:07 INFO - 'installer_path': 'installer.exe', 08:22:07 INFO - 'log_level': 'info', 08:22:07 INFO - 'log_name': 'talos', 08:22:07 INFO - 'log_to_console': True, 08:22:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:22:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:22:07 INFO - 'opt_config_files': (), 08:22:07 INFO - 'pip_index': False, 08:22:07 INFO - 'sps_profile': False, 08:22:07 INFO - 'sps_profile_interval': 0, 08:22:07 INFO - 'suite': 'dromaeojs-e10s', 08:22:07 INFO - 'system_bits': '32', 08:22:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:22:07 INFO - 'title': 'talos-linux64-ix-039', 08:22:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:22:07 INFO - 'use_talos_json': True, 08:22:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:22:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:22:07 INFO - 'work_dir': 'build'} 08:22:07 INFO - [mozharness: 2016-07-20 15:22:07.473166Z] Running clobber step. 08:22:07 INFO - Running pre-action listener: _resource_record_pre_action 08:22:07 INFO - Running main action method: clobber 08:22:07 INFO - rmtree: /builds/slave/test/build 08:22:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:22:07 INFO - Running post-action listener: _resource_record_post_action 08:22:07 INFO - [mozharness: 2016-07-20 15:22:07.953223Z] Finished clobber step (success) 08:22:07 INFO - [mozharness: 2016-07-20 15:22:07.953324Z] Running read-buildbot-config step. 08:22:07 INFO - Running pre-action listener: _resource_record_pre_action 08:22:07 INFO - Running main action method: read_buildbot_config 08:22:07 INFO - Using buildbot properties: 08:22:07 INFO - { 08:22:07 INFO - "project": "", 08:22:07 INFO - "product": "firefox", 08:22:07 INFO - "script_repo_revision": "production", 08:22:07 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 08:22:07 INFO - "repository": "", 08:22:07 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 08:22:07 INFO - "buildid": "20160720065019", 08:22:07 INFO - "pgo_build": "False", 08:22:07 INFO - "basedir": "/builds/slave/test", 08:22:07 INFO - "buildnumber": 91, 08:22:07 INFO - "slavename": "talos-linux64-ix-039", 08:22:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:22:07 INFO - "platform": "ubuntu64_hw", 08:22:07 INFO - "scheduler": "tests-autoland-linux64-talos", 08:22:07 INFO - "branch": "autoland", 08:22:07 INFO - "repo_path": "integration/autoland", 08:22:07 INFO - "revision": "76631f34f9bcfb8b9366200fc541f6d44a024ebb", 08:22:07 INFO - "stage_platform": "linux64", 08:22:07 INFO - "builduid": "6fdafeb9ffd64a08803baab8d9a0451f", 08:22:07 INFO - "slavebuilddir": "test" 08:22:07 INFO - } 08:22:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:22:07 INFO - Running post-action listener: _resource_record_post_action 08:22:07 INFO - [mozharness: 2016-07-20 15:22:07.955782Z] Finished read-buildbot-config step (success) 08:22:07 INFO - [mozharness: 2016-07-20 15:22:07.955872Z] Running download-and-extract step. 08:22:07 INFO - Running pre-action listener: _resource_record_pre_action 08:22:07 INFO - Running main action method: download_and_extract 08:22:07 INFO - mkdir: /builds/slave/test/build/tests 08:22:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:07 INFO - https://queue.taskcluster.net/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:22:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:22:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:22:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:22:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:22:08 INFO - Downloaded 1361 bytes. 08:22:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:22:08 INFO - Using the following test package requirements: 08:22:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:22:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:22:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:22:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:08 INFO - u'jsshell-linux-x86_64.zip'], 08:22:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:22:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:22:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:22:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:22:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:22:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:22:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:22:08 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:08 INFO - https://queue.taskcluster.net/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:22:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:22:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:22:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:22:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:22:09 INFO - Downloaded 22729883 bytes. 08:22:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:22:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:22:11 INFO - Return code: 0 08:22:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:22: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:11 INFO - https://queue.taskcluster.net/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:22:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:22:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:22:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:22:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:22:12 INFO - Downloaded 22729883 bytes. 08:22:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:22:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:22:13 INFO - Return code: 0 08:22:13 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:13 INFO - https://queue.taskcluster.net/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:22:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:22:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:22:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:22:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:22:14 INFO - Downloaded 14403317 bytes. 08:22:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:22:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:22:14 INFO - Return code: 0 08:22: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:14 INFO - https://queue.taskcluster.net/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:22:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:22:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:22:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:22:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:22:16 INFO - Downloaded 57142602 bytes. 08:22:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:22:16 INFO - mkdir: /builds/slave/test/properties 08:22:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:22:16 INFO - Writing to file /builds/slave/test/properties/build_url 08:22:16 INFO - Contents: 08:22:16 INFO - build_url:https://queue.taskcluster.net/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:22:16 INFO - Running post-action listener: _resource_record_post_action 08:22:16 INFO - Running post-action listener: set_extra_try_arguments 08:22:16 INFO - [mozharness: 2016-07-20 15:22:16.938282Z] Finished download-and-extract step (success) 08:22:16 INFO - [mozharness: 2016-07-20 15:22:16.938517Z] Running populate-webroot step. 08:22:16 INFO - Running pre-action listener: _resource_record_pre_action 08:22:16 INFO - Running main action method: populate_webroot 08:22:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:22:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:22:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:22:16 INFO - '--tppagecycles', 08:22:16 INFO - '7'], 08:22:16 INFO - 'tests': ['tsvgm']}}, 08:22:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:22:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:22:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:22:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:22:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:22:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:22:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:16 INFO - 'talos_options': ['--disable-e10s'], 08:22:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:22:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:22:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:16 INFO - 'talos_options': ['--disable-e10s'], 08:22:16 INFO - 'tests': ['damp', 'tps']}, 08:22:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:16 INFO - 'tests': ['damp', 'tps']}, 08:22:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:22:16 INFO - 'tests': ['dromaeo_dom']}, 08:22:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:22:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:22:16 INFO - 'tests': ['basic_compositor_video']}, 08:22:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:22:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:22:16 INFO - 'tests': ['a11yr', 08:22:16 INFO - 'ts_paint', 08:22:16 INFO - 'tpaint', 08:22:16 INFO - 'sessionrestore', 08:22:16 INFO - 'sessionrestore_no_auto_restore', 08:22:16 INFO - 'tabpaint']}, 08:22:16 INFO - 'other-e10s': {'tests': ['a11yr', 08:22:16 INFO - 'ts_paint', 08:22:16 INFO - 'tpaint', 08:22:16 INFO - 'sessionrestore', 08:22:16 INFO - 'sessionrestore_no_auto_restore', 08:22:16 INFO - 'tabpaint']}, 08:22:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:22:16 INFO - 'ts_paint', 08:22:16 INFO - 'tpaint', 08:22:16 INFO - 'sessionrestore', 08:22:16 INFO - 'sessionrestore_no_auto_restore', 08:22:16 INFO - 'tabpaint']}, 08:22:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:22:16 INFO - 'ts_paint', 08:22:16 INFO - 'tpaint', 08:22:16 INFO - 'sessionrestore', 08:22:16 INFO - 'sessionrestore_no_auto_restore', 08:22:16 INFO - 'tabpaint']}, 08:22:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:22:16 INFO - 'tests': ['a11yr', 08:22:16 INFO - 'ts_paint', 08:22:16 INFO - 'tpaint', 08:22:16 INFO - 'sessionrestore', 08:22:16 INFO - 'sessionrestore_no_auto_restore', 08:22:16 INFO - 'tabpaint']}, 08:22:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:22:16 INFO - 'tests': ['a11yr', 08:22:16 INFO - 'ts_paint', 08:22:16 INFO - 'tpaint', 08:22:16 INFO - 'sessionrestore', 08:22:16 INFO - 'sessionrestore_no_auto_restore', 08:22:16 INFO - 'tabpaint']}, 08:22:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:22:16 INFO - 'tests': ['tsvgx', 08:22:16 INFO - 'tsvgr_opacity', 08:22:16 INFO - 'tart', 08:22:16 INFO - 'tscrollx', 08:22:16 INFO - 'cart']}, 08:22:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:22:16 INFO - 'tsvgr_opacity', 08:22:16 INFO - 'tart', 08:22:16 INFO - 'tscrollx', 08:22:16 INFO - 'cart']}, 08:22:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:16 INFO - 'talos_options': ['--disable-e10s'], 08:22:16 INFO - 'tests': ['tp5o']}, 08:22:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:16 INFO - 'tests': ['tp5o']}, 08:22:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:16 INFO - 'talos_options': ['--disable-e10s', 08:22:16 INFO - '--xperf_path', 08:22:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:22:16 INFO - 'tests': ['tp5n']}, 08:22:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:16 INFO - 'talos_options': ['--xperf_path', 08:22:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:22:16 INFO - 'tests': ['tp5n']}}, 08:22:16 INFO - 'talos.zip': {'path': '', 08:22:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:22:16 INFO - Running post-action listener: _resource_record_post_action 08:22:16 INFO - [mozharness: 2016-07-20 15:22:16.956072Z] Finished populate-webroot step (success) 08:22:16 INFO - [mozharness: 2016-07-20 15:22:16.956163Z] Running create-virtualenv step. 08:22:16 INFO - Running pre-action listener: _resource_record_pre_action 08:22:16 INFO - Running main action method: create_virtualenv 08:22:16 INFO - Creating virtualenv /builds/slave/test/build/venv 08:22:16 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 08:22:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:22:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:22:17 INFO - Using real prefix '/usr' 08:22:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:22:17 INFO - Installing distribute.............................................................................................................................................................................................done. 08:22:19 INFO - Installing pip.................done. 08:22:19 INFO - Return code: 0 08:22:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:22: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf18400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa7570>, '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 0xfa8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa8900>, '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': '5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480', '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 08:22: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', 'pip>=1.5'] in /builds/slave/test/build 08:22: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 pip>=1.5 08:22:19 INFO - Using env: {'DISPLAY': ':0', 08:22:19 INFO - 'HOME': '/home/cltbld', 08:22:19 INFO - 'LANG': 'en_US.UTF-8', 08:22:19 INFO - 'LANGUAGE': 'en_US:en', 08:22:19 INFO - 'LOGNAME': 'cltbld', 08:22:19 INFO - 'MAIL': '/var/mail/cltbld', 08:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:19 INFO - 'MOZ_NO_REMOTE': '1', 08:22:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:19 INFO - 'NO_EM_RESTART': '1', 08:22:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:19 INFO - 'PWD': '/builds/slave/test', 08:22:19 INFO - 'SHELL': '/bin/bash', 08:22:19 INFO - 'SHLVL': '1', 08:22:19 INFO - 'TERM': 'linux', 08:22:19 INFO - 'TMOUT': '86400', 08:22:19 INFO - 'USER': 'cltbld', 08:22:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480', 08:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:19 INFO - '_': '/tools/buildbot/bin/python'} 08:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:19 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 08:22:19 INFO - Cleaning up... 08:22:19 INFO - Return code: 0 08:22:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:22: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22: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', '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 0xce9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf18400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa7570>, '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 0xfa8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa8900>, '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': '5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480', '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 08:22: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:22: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 psutil>=3.1.1 08:22:19 INFO - Using env: {'DISPLAY': ':0', 08:22:19 INFO - 'HOME': '/home/cltbld', 08:22:19 INFO - 'LANG': 'en_US.UTF-8', 08:22:19 INFO - 'LANGUAGE': 'en_US:en', 08:22:19 INFO - 'LOGNAME': 'cltbld', 08:22:19 INFO - 'MAIL': '/var/mail/cltbld', 08:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:19 INFO - 'MOZ_NO_REMOTE': '1', 08:22:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:19 INFO - 'NO_EM_RESTART': '1', 08:22:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:19 INFO - 'PWD': '/builds/slave/test', 08:22:19 INFO - 'SHELL': '/bin/bash', 08:22:19 INFO - 'SHLVL': '1', 08:22:19 INFO - 'TERM': 'linux', 08:22:19 INFO - 'TMOUT': '86400', 08:22:19 INFO - 'USER': 'cltbld', 08:22:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480', 08:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:19 INFO - '_': '/tools/buildbot/bin/python'} 08:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:19 INFO - Downloading/unpacking psutil>=3.1.1 08:22: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 08:22: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 08:22: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 08:22: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 08:22: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 08:22: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 08:22:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:22:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:22:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:22:22 INFO - Installing collected packages: psutil 08:22:22 INFO - Running setup.py install for psutil 08:22:22 INFO - building 'psutil._psutil_linux' extension 08:22:22 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 08:22:22 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 08:22:22 INFO - building 'psutil._psutil_posix' extension 08:22:22 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 08:22:22 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 08:22:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:22:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:22:22 INFO - Successfully installed psutil 08:22:22 INFO - Cleaning up... 08:22:22 INFO - Return code: 0 08:22:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:22:22 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:22 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:22 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 0xce9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf18400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa7570>, '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 0xfa8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa8900>, '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': '5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480', '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 08:22:22 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 08:22:22 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 08:22:22 INFO - Using env: {'DISPLAY': ':0', 08:22:22 INFO - 'HOME': '/home/cltbld', 08:22:22 INFO - 'LANG': 'en_US.UTF-8', 08:22:22 INFO - 'LANGUAGE': 'en_US:en', 08:22:22 INFO - 'LOGNAME': 'cltbld', 08:22:22 INFO - 'MAIL': '/var/mail/cltbld', 08:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:22 INFO - 'MOZ_NO_REMOTE': '1', 08:22:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:22 INFO - 'NO_EM_RESTART': '1', 08:22:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:22 INFO - 'PWD': '/builds/slave/test', 08:22:22 INFO - 'SHELL': '/bin/bash', 08:22:22 INFO - 'SHLVL': '1', 08:22:22 INFO - 'TERM': 'linux', 08:22:22 INFO - 'TMOUT': '86400', 08:22:22 INFO - 'USER': 'cltbld', 08:22:22 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480', 08:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:22 INFO - '_': '/tools/buildbot/bin/python'} 08:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:22: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 08:22: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 08:22: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 08:22: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 08:22: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 08:22: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 08:22:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:22:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:22:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:22:24 INFO - Installing collected packages: mozsystemmonitor 08:22:24 INFO - Running setup.py install for mozsystemmonitor 08:22:25 INFO - Successfully installed mozsystemmonitor 08:22:25 INFO - Cleaning up... 08:22:25 INFO - Return code: 0 08:22:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:22:25 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:25 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:25 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 0xce9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf18400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa7570>, '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 0xfa8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa8900>, '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': '5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480', '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 08:22:25 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 08:22:25 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 08:22:25 INFO - Using env: {'DISPLAY': ':0', 08:22:25 INFO - 'HOME': '/home/cltbld', 08:22:25 INFO - 'LANG': 'en_US.UTF-8', 08:22:25 INFO - 'LANGUAGE': 'en_US:en', 08:22:25 INFO - 'LOGNAME': 'cltbld', 08:22:25 INFO - 'MAIL': '/var/mail/cltbld', 08:22:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:25 INFO - 'MOZ_NO_REMOTE': '1', 08:22:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:25 INFO - 'NO_EM_RESTART': '1', 08:22:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:25 INFO - 'PWD': '/builds/slave/test', 08:22:25 INFO - 'SHELL': '/bin/bash', 08:22:25 INFO - 'SHLVL': '1', 08:22:25 INFO - 'TERM': 'linux', 08:22:25 INFO - 'TMOUT': '86400', 08:22:25 INFO - 'USER': 'cltbld', 08:22:25 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480', 08:22:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:25 INFO - '_': '/tools/buildbot/bin/python'} 08:22:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:25 INFO - Downloading/unpacking jsonschema==2.5.1 08:22:25 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 08:22:25 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 08:22:25 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 08:22:25 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 08:22:25 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 08:22:25 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 08:22:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:22:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:22: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 08:22: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 08:22: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 08:22: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 08:22: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 08:22: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 08:22:27 INFO - Downloading functools32-3.2.3-2.tar.gz 08:22:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:22:27 INFO - warning: no files found matching '*.txt' 08:22:27 INFO - no previously-included directories found matching 'build' 08:22:27 INFO - no previously-included directories found matching 'dist' 08:22:27 INFO - no previously-included directories found matching '.git*' 08:22:27 INFO - Installing collected packages: jsonschema, functools32 08:22:27 INFO - Running setup.py install for functools32 08:22:27 INFO - warning: no files found matching '*.txt' 08:22:27 INFO - no previously-included directories found matching 'build' 08:22:27 INFO - no previously-included directories found matching 'dist' 08:22:27 INFO - no previously-included directories found matching '.git*' 08:22:27 INFO - Successfully installed jsonschema functools32 08:22:27 INFO - Cleaning up... 08:22:27 INFO - Return code: 0 08:22:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:22:27 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:27 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:27 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 0xce9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf18400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa7570>, '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 0xfa8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa8900>, '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': '5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480', '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 08:22:27 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 08:22:27 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 08:22:27 INFO - Using env: {'DISPLAY': ':0', 08:22:27 INFO - 'HOME': '/home/cltbld', 08:22:27 INFO - 'LANG': 'en_US.UTF-8', 08:22:27 INFO - 'LANGUAGE': 'en_US:en', 08:22:27 INFO - 'LOGNAME': 'cltbld', 08:22:27 INFO - 'MAIL': '/var/mail/cltbld', 08:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:27 INFO - 'MOZ_NO_REMOTE': '1', 08:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:27 INFO - 'NO_EM_RESTART': '1', 08:22:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:27 INFO - 'PWD': '/builds/slave/test', 08:22:27 INFO - 'SHELL': '/bin/bash', 08:22:27 INFO - 'SHLVL': '1', 08:22:27 INFO - 'TERM': 'linux', 08:22:27 INFO - 'TMOUT': '86400', 08:22:27 INFO - 'USER': 'cltbld', 08:22:27 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480', 08:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:27 INFO - '_': '/tools/buildbot/bin/python'} 08:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:27 INFO - Downloading/unpacking blobuploader==1.2.4 08:22: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 08:22: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 08:22: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 08:22: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 08:22: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 08:22: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 08:22:29 INFO - Downloading blobuploader-1.2.4.tar.gz 08:22:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:22:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:22:29 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 08:22:29 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 08:22:29 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 08:22:29 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 08:22:29 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 08:22:29 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 08:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:22:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:22:30 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 08:22:30 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 08:22:30 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 08:22:30 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 08:22:30 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 08:22:30 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 08:22:30 INFO - Downloading docopt-0.6.1.tar.gz 08:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:22:30 INFO - Installing collected packages: blobuploader, requests, docopt 08:22:30 INFO - Running setup.py install for blobuploader 08:22:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:22:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:22:30 INFO - Running setup.py install for requests 08:22:31 INFO - Running setup.py install for docopt 08:22:31 INFO - Successfully installed blobuploader requests docopt 08:22:31 INFO - Cleaning up... 08:22:31 INFO - Return code: 0 08:22:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:31 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:31 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:31 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 0xce9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf18400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa7570>, '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 0xfa8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa8900>, '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': '5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480', '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 08:22:31 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 08:22:31 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 08:22:31 INFO - Using env: {'DISPLAY': ':0', 08:22:31 INFO - 'HOME': '/home/cltbld', 08:22:31 INFO - 'LANG': 'en_US.UTF-8', 08:22:31 INFO - 'LANGUAGE': 'en_US:en', 08:22:31 INFO - 'LOGNAME': 'cltbld', 08:22:31 INFO - 'MAIL': '/var/mail/cltbld', 08:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:31 INFO - 'MOZ_NO_REMOTE': '1', 08:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:31 INFO - 'NO_EM_RESTART': '1', 08:22:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:31 INFO - 'PWD': '/builds/slave/test', 08:22:31 INFO - 'SHELL': '/bin/bash', 08:22:31 INFO - 'SHLVL': '1', 08:22:31 INFO - 'TERM': 'linux', 08:22:31 INFO - 'TMOUT': '86400', 08:22:31 INFO - 'USER': 'cltbld', 08:22:31 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480', 08:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:31 INFO - '_': '/tools/buildbot/bin/python'} 08:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:22:31 INFO - Running setup.py (path:/tmp/pip-YdSTiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:22:31 INFO - Running setup.py (path:/tmp/pip-gypehX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:22:31 INFO - Running setup.py (path:/tmp/pip-YyZZY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:22:31 INFO - Running setup.py (path:/tmp/pip-NVWSjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:22:31 INFO - Running setup.py (path:/tmp/pip-8RtJfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:22:31 INFO - Running setup.py (path:/tmp/pip-8QOZkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:22:31 INFO - Running setup.py (path:/tmp/pip-QgD2NR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:22:31 INFO - Running setup.py (path:/tmp/pip-ZgdDY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:22:31 INFO - Running setup.py (path:/tmp/pip-diDxnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:22:32 INFO - Running setup.py (path:/tmp/pip-pkNUxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:22:32 INFO - Running setup.py (path:/tmp/pip-WK4TeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:22:32 INFO - Running setup.py (path:/tmp/pip-RGMdX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:22:32 INFO - Running setup.py (path:/tmp/pip-IjSfdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:22:32 INFO - Running setup.py (path:/tmp/pip-ccwN2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:32 INFO - Running setup.py (path:/tmp/pip-eiUTYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:22:32 INFO - Running setup.py (path:/tmp/pip-xRUHGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:22:32 INFO - Running setup.py (path:/tmp/pip-PiPg2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:22:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:22:32 INFO - Running setup.py install for manifestparser 08:22:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:22:32 INFO - Running setup.py install for mozcrash 08:22:32 INFO - Running setup.py install for mozdebug 08:22:32 INFO - Running setup.py install for mozdevice 08:22:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:22:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:22:33 INFO - Running setup.py install for mozfile 08:22:33 INFO - Running setup.py install for mozhttpd 08:22:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:22:33 INFO - Running setup.py install for mozinfo 08:22:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:22:33 INFO - Running setup.py install for mozInstall 08:22:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:22:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:22:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:22:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:22:33 INFO - Running setup.py install for mozleak 08:22:33 INFO - Running setup.py install for mozlog 08:22:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:22:33 INFO - Running setup.py install for moznetwork 08:22:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:22:33 INFO - Running setup.py install for mozprocess 08:22:33 INFO - Running setup.py install for mozprofile 08:22:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:22:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:22:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:22:33 INFO - Running setup.py install for mozrunner 08:22:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:22:34 INFO - Running setup.py install for mozscreenshot 08:22:34 INFO - Running setup.py install for moztest 08:22:34 INFO - Running setup.py install for mozversion 08:22:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:22:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:22:34 INFO - Cleaning up... 08:22:34 INFO - Return code: 0 08:22:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:34 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:34 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:34 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 0xce9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf18400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa7570>, '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 0xfa8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa8900>, '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': '5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480', '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 08:22:34 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 08:22:34 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 08:22:34 INFO - Using env: {'DISPLAY': ':0', 08:22:34 INFO - 'HOME': '/home/cltbld', 08:22:34 INFO - 'LANG': 'en_US.UTF-8', 08:22:34 INFO - 'LANGUAGE': 'en_US:en', 08:22:34 INFO - 'LOGNAME': 'cltbld', 08:22:34 INFO - 'MAIL': '/var/mail/cltbld', 08:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:34 INFO - 'MOZ_NO_REMOTE': '1', 08:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:34 INFO - 'NO_EM_RESTART': '1', 08:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:34 INFO - 'PWD': '/builds/slave/test', 08:22:34 INFO - 'SHELL': '/bin/bash', 08:22:34 INFO - 'SHLVL': '1', 08:22:34 INFO - 'TERM': 'linux', 08:22:34 INFO - 'TMOUT': '86400', 08:22:34 INFO - 'USER': 'cltbld', 08:22:34 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480', 08:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:34 INFO - '_': '/tools/buildbot/bin/python'} 08:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:22:34 INFO - Running setup.py (path:/tmp/pip-af6IeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:22:34 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)) 08:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:22:34 INFO - Running setup.py (path:/tmp/pip-9TRZb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:22:34 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)) 08:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:22:34 INFO - Running setup.py (path:/tmp/pip-2wL4Kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:22:34 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)) 08:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:22:34 INFO - Running setup.py (path:/tmp/pip-JlkgBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:22:34 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)) 08:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:22:34 INFO - Running setup.py (path:/tmp/pip-nOk9_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:22:35 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)) 08:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:22:35 INFO - Running setup.py (path:/tmp/pip-ka18J6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:22:35 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)) 08:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:22:35 INFO - Running setup.py (path:/tmp/pip-EXObG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:22:35 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)) 08:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:22:35 INFO - Running setup.py (path:/tmp/pip-EFhcoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:22:35 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)) 08:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:22:35 INFO - Running setup.py (path:/tmp/pip-HyFhRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:22:35 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)) 08:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:22:35 INFO - Running setup.py (path:/tmp/pip-IYKJsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:22:35 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)) 08:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:22:35 INFO - Running setup.py (path:/tmp/pip-KQefxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:22:35 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)) 08:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:22:35 INFO - Running setup.py (path:/tmp/pip-pUSgdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:22:35 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)) 08:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:22:35 INFO - Running setup.py (path:/tmp/pip-6TzXU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:22:35 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)) 08:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:22:35 INFO - Running setup.py (path:/tmp/pip-LvlteN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:22:35 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)) 08:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:35 INFO - Running setup.py (path:/tmp/pip-8zWqSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:35 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)) 08:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:22:35 INFO - Running setup.py (path:/tmp/pip-ZVtGqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:22:35 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)) 08:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:22:35 INFO - Running setup.py (path:/tmp/pip-kSQYRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:22:35 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)) 08:22:35 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)) 08:22:35 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)) 08:22:35 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)) 08:22:35 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)) 08:22:35 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)) 08:22:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:22:35 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 08:22:35 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 08:22:35 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 08:22:35 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 08:22:35 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 08:22:35 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 08:22:37 INFO - Downloading blessings-1.6.tar.gz 08:22:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:22:37 INFO - Installing collected packages: blessings 08:22:37 INFO - Running setup.py install for blessings 08:22:37 INFO - Successfully installed blessings 08:22:37 INFO - Cleaning up... 08:22:38 INFO - Return code: 0 08:22:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:22:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:22:38 INFO - Reading from file tmpfile_stdout 08:22:38 INFO - Current package versions: 08:22:38 INFO - argparse == 1.2.1 08:22:38 INFO - blessings == 1.6 08:22:38 INFO - blobuploader == 1.2.4 08:22:38 INFO - docopt == 0.6.1 08:22:38 INFO - functools32 == 3.2.3-2 08:22:38 INFO - jsonschema == 2.5.1 08:22:38 INFO - manifestparser == 1.1 08:22:38 INFO - mozInstall == 1.12 08:22:38 INFO - mozcrash == 0.17 08:22:38 INFO - mozdebug == 0.1 08:22:38 INFO - mozdevice == 0.48 08:22:38 INFO - mozfile == 1.2 08:22:38 INFO - mozhttpd == 0.7 08:22:38 INFO - mozinfo == 0.9 08:22:38 INFO - mozleak == 0.1 08:22:38 INFO - mozlog == 3.3 08:22:38 INFO - moznetwork == 0.27 08:22:38 INFO - mozprocess == 0.23 08:22:38 INFO - mozprofile == 0.28 08:22:38 INFO - mozrunner == 6.12 08:22:38 INFO - mozscreenshot == 0.1 08:22:38 INFO - mozsystemmonitor == 0.3 08:22:38 INFO - moztest == 0.7 08:22:38 INFO - mozversion == 1.4 08:22:38 INFO - psutil == 3.1.1 08:22:38 INFO - requests == 1.2.3 08:22:38 INFO - wsgiref == 0.1.2 08:22:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:38 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 0xce9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf18400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa7570>, '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 0xfa8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa8900>, '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': '5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480', '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 08:22:38 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 08:22:38 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 08:22:38 INFO - Using env: {'DISPLAY': ':0', 08:22:38 INFO - 'HOME': '/home/cltbld', 08:22:38 INFO - 'LANG': 'en_US.UTF-8', 08:22:38 INFO - 'LANGUAGE': 'en_US:en', 08:22:38 INFO - 'LOGNAME': 'cltbld', 08:22:38 INFO - 'MAIL': '/var/mail/cltbld', 08:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:38 INFO - 'MOZ_NO_REMOTE': '1', 08:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:38 INFO - 'NO_EM_RESTART': '1', 08:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:38 INFO - 'PWD': '/builds/slave/test', 08:22:38 INFO - 'SHELL': '/bin/bash', 08:22:38 INFO - 'SHLVL': '1', 08:22:38 INFO - 'TERM': 'linux', 08:22:38 INFO - 'TMOUT': '86400', 08:22:38 INFO - 'USER': 'cltbld', 08:22:38 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480', 08:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:38 INFO - '_': '/tools/buildbot/bin/python'} 08:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:38 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)) 08:22:38 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)) 08:22:38 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)) 08:22:38 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)) 08:22:38 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)) 08:22:38 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)) 08:22:38 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)) 08:22:38 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)) 08:22:38 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)) 08:22:38 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)) 08:22:38 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)) 08:22:38 INFO - Cleaning up... 08:22:38 INFO - Return code: 0 08:22:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:22:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:38 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 0xce9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf18400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa7570>, '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 0xfa8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa8900>, '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': '5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480', '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 08:22:38 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 08:22:38 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 08:22:38 INFO - Using env: {'DISPLAY': ':0', 08:22:38 INFO - 'HOME': '/home/cltbld', 08:22:38 INFO - 'LANG': 'en_US.UTF-8', 08:22:38 INFO - 'LANGUAGE': 'en_US:en', 08:22:38 INFO - 'LOGNAME': 'cltbld', 08:22:38 INFO - 'MAIL': '/var/mail/cltbld', 08:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:38 INFO - 'MOZ_NO_REMOTE': '1', 08:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:38 INFO - 'NO_EM_RESTART': '1', 08:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:38 INFO - 'PWD': '/builds/slave/test', 08:22:38 INFO - 'SHELL': '/bin/bash', 08:22:38 INFO - 'SHLVL': '1', 08:22:38 INFO - 'TERM': 'linux', 08:22:38 INFO - 'TMOUT': '86400', 08:22:38 INFO - 'USER': 'cltbld', 08:22:38 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480', 08:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:38 INFO - '_': '/tools/buildbot/bin/python'} 08:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:22:38 INFO - Cleaning up... 08:22:38 INFO - Return code: 0 08:22:38 INFO - Running post-action listener: _resource_record_post_action 08:22:38 INFO - Running post-action listener: _start_resource_monitoring 08:22:38 INFO - Starting resource monitoring. 08:22:38 INFO - [mozharness: 2016-07-20 15:22:38.707202Z] Finished create-virtualenv step (success) 08:22:38 INFO - [mozharness: 2016-07-20 15:22:38.707642Z] Running install step. 08:22:38 INFO - Running pre-action listener: _resource_record_pre_action 08:22:38 INFO - Running main action method: install 08:22:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:22:38 INFO - Reading from file tmpfile_stdout 08:22:38 INFO - Detecting whether we're running mozinstall >=1.0... 08:22:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:22:38 INFO - Reading from file tmpfile_stdout 08:22:38 INFO - Output received: 08:22:38 INFO - Usage: mozinstall [options] installer 08:22:38 INFO - Options: 08:22:38 INFO - -h, --help show this help message and exit 08:22:38 INFO - -d DEST, --destination=DEST 08:22:38 INFO - Directory to install application into. [default: 08:22:38 INFO - "/builds/slave/test"] 08:22:38 INFO - --app=APP Application being installed. [default: firefox] 08:22:38 INFO - mkdir: /builds/slave/test/build/application 08:22:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:22:55 INFO - Reading from file tmpfile_stdout 08:22:55 INFO - Output received: 08:22:55 INFO - /builds/slave/test/build/application/firefox/firefox 08:22:55 INFO - Running post-action listener: _resource_record_post_action 08:22:55 INFO - [mozharness: 2016-07-20 15:22:55.356131Z] Finished install step (success) 08:22:55 INFO - [mozharness: 2016-07-20 15:22:55.356413Z] Running run-tests step. 08:22:55 INFO - Running pre-action listener: _resource_record_pre_action 08:22:55 INFO - Running main action method: run_tests 08:22:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:22:55 INFO - Python 2.7.3 08:22:55 INFO - Return code: 0 08:22:55 INFO - grabbing minidump binary from tooltool 08:22:55 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:55 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 0xfa7570>, '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 0xfa8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa8900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:22:55 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 08:22:55 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 08:22:55 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 08:22:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:22:55 INFO - Return code: 0 08:22:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:22:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:22:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:22:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:22:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:22:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:22:55 INFO - Using env: {'DISPLAY': ':0', 08:22:55 INFO - 'HOME': '/home/cltbld', 08:22:55 INFO - 'LANG': 'en_US.UTF-8', 08:22:55 INFO - 'LANGUAGE': 'en_US:en', 08:22:55 INFO - 'LOGNAME': 'cltbld', 08:22:55 INFO - 'MAIL': '/var/mail/cltbld', 08:22:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:22:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:55 INFO - 'MOZ_NO_REMOTE': '1', 08:22:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:55 INFO - 'NO_EM_RESTART': '1', 08:22:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:55 INFO - 'PWD': '/builds/slave/test', 08:22:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:22:55 INFO - 'SHELL': '/bin/bash', 08:22:55 INFO - 'SHLVL': '1', 08:22:55 INFO - 'TERM': 'linux', 08:22:55 INFO - 'TMOUT': '86400', 08:22:55 INFO - 'USER': 'cltbld', 08:22:55 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480', 08:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:55 INFO - '_': '/tools/buildbot/bin/python'} 08:22:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:22:55 INFO - mozversion application_buildid: 20160720065019 08:22:55 INFO - mozversion application_changeset: 76631f34f9bcfb8b9366200fc541f6d44a024ebb 08:22:55 INFO - mozversion application_display_name: Nightly 08:22:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:22:55 INFO - mozversion application_name: Firefox 08:22:55 INFO - mozversion application_remotingname: firefox 08:22:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 08:22:55 INFO - mozversion application_vendor: Mozilla 08:22:55 INFO - mozversion application_version: 50.0a1 08:22:55 INFO - mozversion platform_buildid: 20160720065019 08:22:55 INFO - mozversion platform_changeset: 76631f34f9bcfb8b9366200fc541f6d44a024ebb 08:22:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 08:22:55 INFO - mozversion platform_version: 50.0a1 08:22:55 INFO - using testdate: 1469028175 08:22:55 INFO - actual date: 1469028175 08:22:55 INFO - starting webserver on 'localhost:46970' 08:22:55 INFO - SUITE-START | Running 2 tests 08:22:55 INFO - TEST-START | dromaeo_css 08:22:55 INFO - operating with platform_type : linux_ 08:22:55 INFO - Initialising browser for dromaeo_css test... 08:22:55 INFO - TEST-INFO | started process 32378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD0208a/profile http://localhost:46970/getInfo.html) 08:23:00 INFO - PROCESS | 32378 | __metrics Screen width/height:1600/1200 08:23:00 INFO - PROCESS | 32378 | colorDepth:24 08:23:00 INFO - PROCESS | 32378 | Browser inner width/height: 1024/697 08:23:00 INFO - PROCESS | 32378 | __metrics 08:23:01 ERROR - PROCESS | 32378 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 08:23:02 INFO - TEST-INFO | 32378: exit 0 08:23:02 INFO - Browser initialized. 08:23:02 INFO - Running cycle 1/1 for dromaeo_css test... 08:23:02 INFO - TEST-INFO | started process 32499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD0208a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:23:14 INFO - PROCESS | 32499 | RSS: Main: 168251392 08:23:14 INFO - PROCESS | 32499 | 08:24:03 INFO - PROCESS | 32499 | 1469028243894 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] 08:26:17 INFO - PROCESS | 32499 | Cycle 1(1): loaded http://localhost:46970/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46970/tests/dromaeo/cssquery-ext.html) 08:26:19 INFO - PROCESS | 32499 | RSS: Main: 168873984 08:26:19 INFO - PROCESS | 32499 | 08:29:21 INFO - PROCESS | 32499 | Cycle 1(1): loaded http://localhost:46970/tests/dromaeo/cssquery-ext.html (next: http://localhost:46970/tests/dromaeo/cssquery-jquery.html) 08:29:22 INFO - PROCESS | 32499 | RSS: Main: 168964096 08:29:22 INFO - PROCESS | 32499 | 08:32:24 INFO - PROCESS | 32499 | Cycle 1(1): loaded http://localhost:46970/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46970/tests/dromaeo/cssquery-mootools.html) 08:32:25 INFO - PROCESS | 32499 | RSS: Main: 173395968 08:32:25 INFO - PROCESS | 32499 | 08:35:26 INFO - PROCESS | 32499 | Cycle 1(1): loaded http://localhost:46970/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46970/tests/dromaeo/cssquery-prototype.html) 08:35:27 INFO - PROCESS | 32499 | RSS: Main: 167395328 08:35:27 INFO - PROCESS | 32499 | 08:38:30 INFO - PROCESS | 32499 | Cycle 1(1): loaded http://localhost:46970/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46970/tests/dromaeo/cssquery-yui.html) 08:38:31 INFO - PROCESS | 32499 | RSS: Main: 168996864 08:38:31 INFO - PROCESS | 32499 | 08:41:33 INFO - PROCESS | 32499 | Cycle 1(1): loaded http://localhost:46970/tests/dromaeo/cssquery-yui.html (next: http://localhost:46970/tests/dromaeo/cssquery-dojo.html) 08:41:34 INFO - PROCESS | 32499 | RSS: Main: 170475520 08:41:34 INFO - PROCESS | 32499 | 08:41:34 INFO - PROCESS | 32499 | __start_tp_report 08:41:34 INFO - PROCESS | 32499 | _x_x_mozilla_page_load 08:41:34 INFO - PROCESS | 32499 | _x_x_mozilla_page_load_details 08:41:34 INFO - PROCESS | 32499 | |i|pagename|runs| 08:41:34 INFO - PROCESS | 32499 | |0;dojo.html;2631.329011102169;2636.340914771308;2647.682278126625;2676.384431580735;2680.9061682841093;4927.113119638464;5004.599632029438;5015.172496538076;5015.5486006259425;5021.071101846161;4772.761361931907;4805;4834.927476087862;4867.537583929521;4873.805047798092;4444.622207112399;4484.394606728099;4510.188166130095;4568.063546972862;4572.565606267399;4484.1928452878465;4499.122671079141;4525.411696479453;4536.138133754593;4618.12255671423;4472.805343511459;4591.44902611687;4664.5102264262105;4679.227927391977;4680.391549098613;4553.567411095941;4593.494715581283;4600.539946005372;4605.976970115128;4622.8150873965005;4298.828046878121;4406.7355958642265;4428.40216570762;4438.800253988578;4466.642668586538;4755.2153894607345;4780.49804770501;4814.807407703687;4881.951180488185;4936.111499930011;5188.7146206958605;5200.97399513;5214.765335559871;5235.869103272411;5285.550728188108;5297.152455607123;5327.200919862013;5339.546138578186;5367.892642147135;5370.113931201347;4944.431390390151;4978.527039931273;4982.252662100642;4982.825601104017;4986.401631804134;5254.343207099113;5414.242006119146;5472.91790623141;5480.232767412565;5481.479259470344;5211.739413029333;5235.502627250406;5253.737313134328;5304.779900622878;5307.28351672527;5348.652337598043;5354.491323324278;5373.596980226421;5376.596755243372;5413.323334583177;5104.1578139606545;5153.845384638392;5264.736763161826;5276.287701160294;5278.366596008504;5164.948350516522;5180.404253510819;5184.196449550326;5196.9865876154545;5216.504432078947;4427.29163333865;4430.014142581131;4436.0462500562535;4442.111577684476;4487.41663583732;3785.8296376663116;3793.8103094845146;3819.0452386903276;3869.496965394537;3877.922441551153;4577.717521333395;4597.977010114928;4598.3102534620075;4617.907641847144;4640.83757068501;5259.132243179909;5308.044551980681;5312.335958005249;5314.681119132864;5355.705436201047;4417.491988421309;4530.524294948983;4555.703879247838;4588.49526552079;4638.234691275969;4712.95287047132;4729.290606409066;4737.928931066037;4770.403699537558;4783.378160839138;4937.901241975069;4938.407391113089;4941.431735350337;4953.876153096201;4979.3526841510375;5152.845414637567;5177.4822517747925;5249.658772179796;5303.36359636846;5352.652077615098;4920.92618610714;4943.382077240345;4948.307236986752;4977.228529577921;4982.775775090057;5162.328897243335;5189.040027594907;5189.948100519097;5201.609879258995;5251.343582052244;5158.509941555546;5211.609129315392;5213.791448342024;5245.868853278546;5270.578353731769;5082.4409314976065;5083.313752643346;5099.260607212008;5138.4604616514725;5147.871303217449;5077.644564880571;5094.7962081516325;5099.617528685438;5117.02776472469;5142.5885929126325;4874.049560335842;4923.926141107814;4924.4090709115135;4968.950310496849;4983.127952608206;4983.352164218629;5004.799808007639;5091.312672789274;5103.311053007945;5129.076766182123;5070.340855688737;5109.259157422079;5126.436092029949;5162.767675454688;5183.688978661293 08:41:34 INFO - PROCESS | 32499 | |1;ext.html;548.6653141583633;569.5045310579796;581.6248519704787;582.9795957141499;605.1769593353036;37269.627303726986;40595.39106913395;40797.79601101994;40871.386929196015;40901.38647920276;39983;40341.19317613646;40415.59584404155;40520.79739601298;40532.39201411974;7899.723509677163;8023;8028;8032.3172530335;8045.436819422614;7857.646405911748;7927.722529711461;7928;7939.36485081195;7948.125706172316;7934.285914267714;7973.880391794099;8006.039275286945;8014.238647328523;8024.719134830282;7798.7270445534705;7901.130875603708;7931.365490760783;7941.920580794176;7961.601919904039;7817.491863028885;7907.209279072104;7932.325752311061;7966.721164759264;7975.082865470487;38628;38772.41841372382;38885.41671874924;38886;39060;3099.2406860319143;3180.4434224010706;3327.633960264369;3443.6900678939014;3833.5016447861876;28045.43909121806;29907;30694.079177624706;30749;30796.692033079606;3515.630858759819;3544.964550354515;3602;3700.1859590889962;3719.590845007074;271074;274703;275404;276593;278281.6085919578;57135;57225.71387143037;57480.425195747506;57575.71212143996;57618.423815762144;33599.824006159666;34525.30949380998;34620.82689586536;36267.63732362695;52973.205401919;15521.611959700873;15683.921580392025;15693.921530392276;15707.293171807296;15720.92139539295;11933;12024.699382515331;12028.27830330183;12028.939855300667;12030.939845300718;18630.254789808256;18982.905085474762;19014.954177520092;19036.42890713281;19070.42788716313;6680.298568650319;6767.492438067165;6793.898091528631;6830.351116643911;6927.203371612329;828.8093738440072;937.6811883959487;1023.2428003277521;1028.3264461777549;1049.8740151181755;29324;29589.408211836075;29754.553681694793;29838.55242171369;30053.248668783457;897.7306807957586;939.0843927170954;946.4226821638932;1043.7234132954773;1057.318029870729;14672.486462973744;14907.403703851942;15203.087814731152;15295.617609559627;15528.922355388377;405663;406588;407186;409338;410301;51307.23039154341;51665.60842328369;51719.48280517222;51801.7409912948;52077.479225207266;1148.9942550287194;1190.7975644140517;1192.3442106841376;1197.8981786548068;1203.6810245285008;26928.192154235403;28004;28336.85831570829;28713.28216794597;29088.7091129086;43637.78181109074;43779.78110109429;44011.77994110009;44208.33687494626;44225.55774442343;346007;347419;347713;348003;348443;25925.481490369708;25993.480130397664;26411.73588264093;26441.471170576864;26455.735442645328;43312.133757325304;43525.12949740924;43611.78194109009;43837;43998.560014399445;36616.26767464689;37608.43587346137;38111.42832857454;38390.616093838704;38830.61169388383;37296.44055339226;37889.43165852459;37926.24147517089;38284.617153828105;38765.80617097009;37104.91845897003;37480.250394992494;38223.80888095542;38448.23103537969;41187.588124118374;31113.37773244568;34138.65861341355;34674.133146671535;34726.65273347234;35278;26349.20952371432;26463.867680661475;26622.866885666223;26647.33381665474;26892.462150756484 08:41:34 INFO - PROCESS | 32499 | |2;jquery.html;360.9747317687763;370.0729672171212;370.91839795245056;377.9417630634227;384.3619591478145;16124.758128628066;16932.83067169328;17473.213705383256;17501.7374739379;17502.649947001068;16646.83353166468;17187.656246875085;17617.471475855713;17731.113444327766;17785.110744462756;5006.849794506162;5228.111221092423;5230.110881150214;5230.529252367286;5244.685318880879;3787.2236191580796;5140.7172605506685;5826.213461182729;6051.606645568024;6086.421789929949;6122.1735065766;6128.295246046695;6133.938660613404;6136.96931515344;6157.291911430176;5019.272205530196;5252.921206181911;5299.33758280215;5367.704776237305;5393.541548968303;5078.7968481260705;5108.923366149511;5132.999065182291;5148.099082660557;5224.63427560071;18813.623727525373;19780;19926.30257940965;20829.37511874631;21237;1786.214065811039;1862.469196279054;2071.927482538104;2120.8409369297365;2334.6147885598857;9738.220942324597;9913.405195688281;9986.450745209011;11829.704257393549;13286.933565332112;1624.3259047495276;1736.557177919635;1742.5904912345588;1772.3176577017812;1774.3700986149988;65975.3402465974;70445.94331085037;71438.64280678563;73106.63446682786;74650;9984.20126389887;10139.239557033105;10340.172786177087;10345.482725863827;10436.478176091165;14028.789568156486;14072.507462238773;14111.78832317516;14123.505677301246;14158.433662653584;7029.22678505364;7057.153141623038;7376.96311518439;7440.702371905063;7604.391648668204;6901.413379862768;6903.1371078615175;6929.099217101744;7081.610511421818;7268.45486588508;4422.982713975739;4429.313456414261;4430.822767089345;4439;4458.5987261146;1516.2115699836245;1604.7833542471617;1633.1426001349387;1788.4098247578268;1941.1652989214774;811.9553424561587;831.584207896052;880.903100658927;903.1239697493421;918.083981460436;16995.40516081956;17070.43943408474;17350.65298694019;17522.737158942626;17849.28602855897;939.9953000234955;956.1729104324849;958.7219706285099;962.2350231565922;974.444566597047;9533;9908.256880733974;9982;10015.69952901414;10023.599056037823;388752;403837;404012;404297;405925;75877.24122758702;79216.60391698005;79326.60336698279;79528.20471795324;81173;866.120887299379;883.0595415882065;899.9685011024714;911.284641556375;913.4017218721748;12473.501059957864;15377.692446151239;15671.451499197474;15787.289571969059;15867.365305387655;35412.82293588515;36641.45037824381;37413;39093.02267443223;39252.214955700154;48302.5169748298;48536.5146348532;49110.75444622754;49833;53524.4647553535;7485.1766305707415;7687.154413014676;7819.84360312802;8035.316998055231;8067.515949043076;8237.258646721824;10515.78968420612;11162.274452160584;11259.49332280033;12345.209944558168;10452.843207351743;10639.255252132276;11145.49845256949;11246.325220486797;11307;9772.951135244279;10635.94682026585;10659;10803.729906752395;11444.828327574927;11171.66485005451;11269.49287282058;11341.773164536828;11392.202545822045;11639.359835209145;7675.884861726967;7743.612819359122;7777.494462859896;7964.283214510722;8336.666533338599;10459.529321180413;10617.734556636145;11223.66329010131;11230.55077796879;11328.0742273812 08:41:34 INFO - PROCESS | 32499 | |3;mootools.html;1381.861813818618;1417.7377185220732;1493.7311283968882;1704.9744253836202;1733.7659415978846;6809.080774095496;7518.511296765706;7544.886826697591;8044.8391032179325;8106.878396824052;7703.614819259029;7900.723474678387;7934.880976785353;7944.126146123922;7965.04419469663;2216.7229096362953;2254.954900901981;2263.151318255654;2263.9773602264013;2269.4439862233776;2210.4805370737863;2237.161064600775;2269.353234328217;2277.7038984931937;2280.9543809123807;2218.3566765637947;2243.0915479230857;2255.8533695309834;2263.7962583367494;2267.161150374364;2185.825133989277;2199.8130158936588;2204.4599073227;2215.1139544182297;2221.9333419997424;2177.1835561664375;2187.595294870438;2188.4638263625357;2188.5075857931997;2194.4513871532117;7882.5270483771155;7924.960375198087;7930.405219608552;7986.041674998979;7988.081370642392;4600.05698831742;4686.812527498896;4729.763511824395;4736;4736.455307639631;2804.859757012141;2909.970900291012;2949.7935144539892;2955.335049613841;2958.5562165675105;912.2884150362728;932.244881645869;953.7329547726648;954.1079091049891;965.5268918230087;10677.83983240252;10696.839547406795;10701.090407315387;10722.303050301784;10793.406362650052;4039.717219794586;4240.469941257343;4301.247281725686;4396.296592545177;4400.845970391021;9220.907790922005;9221.585028673726;9224.077592240723;9229.35394522377;9230.400023998418;4721.480637129913;4723.055388922229;4731.219348807408;4760.238361862085;4774.21225497789;3663.377225871608;4136.627703506639;4254.808533615995;4293.484781826201;4312.180685669713;3649.8905032849057;3673.3020726061964;3735.9439608405896;3775.9433608495897;3791.3933770596573;1153.3195414705365;1164.4876254448016;1171.654361963223;1171.9062475001979;1173.747644256489;695.9478039147084;812.8049268175595;819.3199644295221;838.3209600223838;848.6732607945985;4849.248366503198;5192.896142077213;5232.73836308183;5290.947090529045;5316.229146773773;398.44615983782563;400.2635151321582;411.2248411743884;412.9938050929238;416.6063070398444;3378.9324213515592;3466.4973578830927;3484.4773284007097;3514.5606799150105;3559.2169722660974;9299.67451139207;9539.189168920719;9578.233741300679;9634.181094606896;9690.12788849007;9542.61829526825;9590.184834289024;9621.230301575857;9625.51872406377;9643.373180743229;7163.820904477326;7246.782596522113;7280.199178090405;7324.560526368435;7342.48602597813;4991.575716064175;5032.3206367139965;5057.216131499624;5060.3927528696795;5084.618653600921;8523.872141918;8708.78228044304;8712.869306960274;8719;8816.823663526566;8953.418027828171;9009.324300677345;9027.232685221566;9045.819083618422;9054;5933.703314834327;6605.372489613479;6758.594484330956;6811.489138314745;6888.931110688829;7599.088109426904;7626.847463050597;7653.57905315213;7666.69333226687;7673.462857600138;6579.736810527525;6676.632785196666;6689.866202676017;6714.664266786739;6875;6548.443382312366;6577.934220657924;6671.39957403836;6782;6882.483813713891;5999.1901093351835;6026.758929642765;6039.124326972652;6089.604175728564;6091.086337049478;4412.205802955499;4414.117176564636;4448.9110217796115;4459.732416055047;4527.977360113178;4362.454693163355;4375.6718246132305;4462.509123996293;4530.818767249405;4533.274676051816 08:41:34 INFO - PROCESS | 32499 | |4;prototype.html;296.9777266704997;304.36387949186195;310.7374268742912;311.08851066375513;312.1649587353828;5112.8977420451565;5165.251038599406;5165.896682066356;5169.715665638389;5180.974095129519;5047.949520504794;5066.138756411409;5092.694438333702;5097.770600322985;5106.846794596158;3772.566154892188;3921.3529767588316;3988.3818008208773;3991.800409979504;4042.43405923171;3991.560928297885;3998.7200895937294;4001.1397549526846;4003.779792111433;4012.6589239914642;3988.7036713068223;4001.379786133154;4010.7794071326066;4016.116454380032;4018.5177778666457;3741.8129093545213;3897.0647044709067;3976.6818654507715;3986.3023970804993;3989.501312335958;3438.157651375404;3439.6560343965652;3448.5689288838894;3458.342914846171;3464.6015708193627;5028.145215313405;5049.64652474327;5055.115354812893;5055.317532133152;5055.368078990126;4211.978940105279;4525.411696479469;4550.749708766017;4575.22221222393;4584.381108550369;5281.63028587999;5293.311869456985;5309.787608495655;5313.734313284359;5345.973270133663;3742.4573436851506;3746.9625303747157;3751.906202344936;3754.554496518833;3768.3405404054456;5326.92009619856;5667.319921609434;5673.716314184274;5694.718688295142;5706.657600543981;3783.4703141559653;3835.1562656215588;3852.3836186210074;3855.8843234703004;3871.632194941476;3873.96126038736;3877.65101140893;3893.493845800028;3894.4937158169255;3899.922001559953;4473.261911784584;4482.148391805546;4507.11544611449;4522.140793249272;4535.16099521583;5211.348581427322;5350.4649535046965;5362.2224777407055;5386.8383948481605;5417.970585588804;1333.852886517594;1348.191085348783;1353.41126609925;1355.2342926246836;1356.7083077138464;816.4366587054913;835.6114406800867;853.2320911179863;873.750980970433;878.3456325037888;4597.839075632337;4741.976290118596;4749.881252968704;4753.453352864396;4757.881052973703;5569.053260945649;5593.20339830085;5597.74810133545;5603.299587551556;5611.270534830527;4460.955390446119;4778.593819525379;4784.091022705675;4785.904281914342;4803.18345881201;2896.9710302897124;2935.77981651377;2950.1886981080374;2951.778616603763;2961.4077184563175;5165.845024649267;5176.534111929945;5185.507376799198;5202.401723801811;5202.453742357074;5477.3427188737605;5606.635568688022;5646.661200327993;5697.487226149667;5703.460065782216;5143.717095559706;5146.099432599355;5160.948390516047;5162.174052151638;5165.74171291434;5503.229547863222;5544;5557.583181261502;5563.833085007456;5578.30271216098;5303.946960530346;5395.4604539545735;5412.972935135299;5416.322959630046;5428.348598168245;5127.307813445286;5151.175811870233;5156.458571849902;5163.845084647466;5169.53474187325;3935.7048221384084;3969.523657161159;4009.939850902297;4031;4041.4948131483566;5267.894642107213;5467.835964921059;5505.889882202414;5523.751431185687;5559.11054231321;5278.5513231374225;5303.15149576066;5304.045271851104;5316.468353164652;5319.920201196907;5104.617153713412;5303.098473259478;5314.202869569595;5314.5650674318495;5324.787008519771;5309.256704061511;5323;5325.627206095536;5331.600129990344;5340.810267790343;5059.723124593874;5204.323437953042;5289.788408463773;5335.493128152819;5347.251384806053;5288.206768984683;5295.576353891603;5320.680759154463;5329.307190065267;5341.599380046434 08:41:34 INFO - PROCESS | 32499 | |5;yui.html;643.6170478565253;651.9348065193478;668.6656671664165;738.3198987674743;765.4985984180361;12166.81749773753;12594.181378210433;12617.55838545651;12648.051396145303;12662.556810511634;11999.040076793857;12078.396080195998;12081.456334464949;12113.878861211408;12169.391530423465;606.7633622887056;761.3908872901684;765.6975494679598;778.7897267737736;780.157429975625;780.7150390107598;785.0775338976708;785.8899754034439;786.4927122006302;787.3425689549233;833.7748807821885;836.8033512124646;836.8284501677142;837.3636036612188;837.857564214082;824.4599787139433;825.8926339575877;826.2274773087153;828.225609055535;829.3158144530786;605.0984033789666;608.9299730531002;609.0468416927495;610.1518888744648;611.1688104178314;11916.523339066427;11974.161808673396;12008.759824803543;12015.85849344311;12051.939740301243;13202.471901123943;13550.119242249222;13851;13883.4446622135;13936.163830170222;10274.486275686186;10316.638917637847;10359.32664376813;10390.740231494197;10444.529996150115;3256.348730253959;3282.2943067240417;3309.38776326378;3355.580552430946;3366.0575038989123;60113.699431503;60513.69743151256;61425.38574614286;61548.38451615516;61748;10372.222083343779;10630.627928022637;10669.89330106689;10770.299930504649;11218.551257949754;19624.116914738872;19648.60702785936;19662.901685491768;19667.508312292306;19668.11493482797;6969.2682268362105;7008;7014.263502332182;7241.131064272216;7269.345758881726;3653.707703383723;3700.555933287969;3710.3692372296773;3747.8500859965297;3770.792606406619;2852.35821940066;2926.1367896470592;2927.4145170965894;2936.0604606526135;2939.0595009596723;485.6115107913655;510.79312878284355;513.8715321169708;515.5334422347781;521.890403015371;487.77318546875875;488.16280079663545;549.2749570566893;617.4936552027294;629.380060640269;7644.388448924073;8013.7996550085545;8164;8248.793780155544;8293.004839419309;590.35356284868;591.961522501036;593.8990371636833;604.1994357476361;605.1618508365857;3695.3533131701843;3698.204885949534;3800.315943130208;3882.6699730522655;3989.2819292527624;63138;94597.52701236587;96815.51592241993;97842;98467;43053;43678.344824827655;70094;76958.23041769622;78244;44652.77673611611;63260.68369658214;68424.65787671029;71538.2846171542;74829;8586.742397728078;9403.811923761623;9568.56941437623;9629.662961796303;9725.173360264456;42537.574624253364;43550;44534.77732611316;45655.543444565126;46220.76889615531;35872;40012.59987400205;47530.049399011135;53835;55640;11519.481623327138;11693;11842.46708898119;11871.703207419883;11890.524379024742;13374.063815533209;13505;13549.051566390259;13611.863881361456;14347.92826035863;12182.939085304517;12702.491900323883;12960.675983100498;13076.934615326862;13681.247531385869;12422.440990155645;12449.315287658903;12870.67823304425;13020.934895325463;13191;11608.593699220486;11812.76374472523;11970.281783093042;12077.57728479499;12142.392880356123;9800.607975680892;9840.3603765755;9926.354786938826;10005.153208863647;10217.591296348062;8668.26319762802;9397.812043759222;9845.261605379483;10027.899721002697;10151.340162889388 08:41:34 INFO - PROCESS | 32499 | __end_tp_report 08:41:34 INFO - PROCESS | 32499 | __start_cc_report 08:41:34 INFO - PROCESS | 32499 | _x_x_mozilla_cycle_collect,415 08:41:34 INFO - PROCESS | 32499 | __end_cc_report 08:41:34 INFO - PROCESS | 32499 | __startTimestamp1469029294249__endTimestamp 08:41:34 INFO - PROCESS | 32499 | 08:41:34 INFO - PROCESS | 32499 | ------- Summary: start ------- 08:41:34 INFO - PROCESS | 32499 | Number of tests: 6 08:41:34 INFO - PROCESS | 32499 | 08:41:34 INFO - PROCESS | 32499 | [#0] dojo.html Cycles:165 Average:4860.14 Median:4982.78 stddev:527.52 (10.6%) stddev-sans-first:499.32 08:41:34 INFO - PROCESS | 32499 | Values: 2631.3 2636.3 2647.7 2676.4 2680.9 4927.1 5004.6 5015.2 5015.5 5021.1 4772.8 4805.0 4834.9 4867.5 4873.8 4444.6 4484.4 4510.2 4568.1 4572.6 4484.2 4499.1 4525.4 4536.1 4618.1 4472.8 4591.4 4664.5 4679.2 4680.4 4553.6 4593.5 4600.5 4606.0 4622.8 4298.8 4406.7 4428.4 4438.8 4466.6 4755.2 4780.5 4814.8 4882.0 4936.1 5188.7 5201.0 5214.8 5235.9 5285.6 5297.2 5327.2 5339.5 5367.9 5370.1 4944.4 4978.5 4982.3 4982.8 4986.4 5254.3 5414.2 5472.9 5480.2 5481.5 5211.7 5235.5 5253.7 5304.8 5307.3 5348.7 5354.5 5373.6 5376.6 5413.3 5104.2 5153.8 5264.7 5276.3 5278.4 5164.9 5180.4 5184.2 5197.0 5216.5 4427.3 4430.0 4436.0 4442.1 4487.4 3785.8 3793.8 3819.0 3869.5 3877.9 4577.7 4598.0 4598.3 4617.9 4640.8 5259.1 5308.0 5312.3 5314.7 5355.7 4417.5 4530.5 4555.7 4588.5 4638.2 4713.0 4729.3 4737.9 4770.4 4783.4 4937.9 4938.4 4941.4 4953.9 4979.4 5152.8 5177.5 5249.7 5303.4 5352.7 4920.9 4943.4 4948.3 4977.2 4982.8 5162.3 5189.0 5189.9 5201.6 5251.3 5158.5 5211.6 5213.8 5245.9 5270.6 5082.4 5083.3 5099.3 5138.5 5147.9 5077.6 5094.8 5099.6 5117.0 5142.6 4874.0 4923.9 4924.4 4969.0 4983.1 4983.4 5004.8 5091.3 5103.3 5129.1 5070.3 5109.3 5126.4 5162.8 5183.7 08:41:34 INFO - PROCESS | 32499 | 08:41:34 INFO - PROCESS | 32499 | [#1] ext.html Cycles:180 Average:49811.18 Median:38018.83 stddev:91612.99 (241.0%) stddev-sans-first:91795.33 08:41:34 INFO - PROCESS | 32499 | Values: 548.7 569.5 581.6 583.0 605.2 37269.6 40595.4 40797.8 40871.4 40901.4 39983.0 40341.2 40415.6 40520.8 40532.4 7899.7 8023.0 8028.0 8032.3 8045.4 7857.6 7927.7 7928.0 7939.4 7948.1 7934.3 7973.9 8006.0 8014.2 8024.7 7798.7 7901.1 7931.4 7941.9 7961.6 7817.5 7907.2 7932.3 7966.7 7975.1 38628.0 38772.4 38885.4 38886.0 39060.0 3099.2 3180.4 3327.6 3443.7 3833.5 28045.4 29907.0 30694.1 30749.0 30796.7 3515.6 3545.0 3602.0 3700.2 3719.6 271074.0 274703.0 275404.0 276593.0 278281.6 57135.0 57225.7 57480.4 57575.7 57618.4 33599.8 34525.3 34620.8 36267.6 52973.2 15521.6 15683.9 15693.9 15707.3 15720.9 11933.0 12024.7 12028.3 12028.9 12030.9 18630.3 18982.9 19015.0 19036.4 19070.4 6680.3 6767.5 6793.9 6830.4 6927.2 828.8 937.7 1023.2 1028.3 1049.9 29324.0 29589.4 29754.6 29838.6 30053.2 897.7 939.1 946.4 1043.7 1057.3 14672.5 14907.4 15203.1 15295.6 15528.9 405663.0 406588.0 407186.0 409338.0 410301.0 51307.2 51665.6 51719.5 51801.7 52077.5 1149.0 1190.8 1192.3 1197.9 1203.7 26928.2 28004.0 28336.9 28713.3 29088.7 43637.8 43779.8 44011.8 44208.3 44225.6 346007.0 347419.0 347713.0 348003.0 348443.0 25925.5 25993.5 26411.7 26441.5 26455.7 43312.1 43525.1 43611.8 43837.0 43998.6 36616.3 37608.4 38111.4 38390.6 38830.6 37296.4 37889.4 37926.2 38284.6 38765.8 37104.9 37480.3 38223.8 38448.2 41187.6 31113.4 34138.7 34674.1 34726.7 35278.0 26349.2 26463.9 26622.9 26647.3 26892.5 08:41:34 INFO - PROCESS | 32499 | 08:41:34 INFO - PROCESS | 32499 | [#2] jquery.html Cycles:180 Average:24887.13 Median:405111.00 stddev:66247.30 (16.4%) stddev-sans-first:66407.55 08:41:34 INFO - PROCESS | 32499 | Values: 361.0 370.1 370.9 377.9 384.4 16124.8 16932.8 17473.2 17501.7 17502.6 16646.8 17187.7 17617.5 17731.1 17785.1 5006.8 5228.1 5230.1 5230.5 5244.7 3787.2 5140.7 5826.2 6051.6 6086.4 6122.2 6128.3 6133.9 6137.0 6157.3 5019.3 5252.9 5299.3 5367.7 5393.5 5078.8 5108.9 5133.0 5148.1 5224.6 18813.6 19780.0 19926.3 20829.4 21237.0 1786.2 1862.5 2071.9 2120.8 2334.6 9738.2 9913.4 9986.5 11829.7 13286.9 1624.3 1736.6 1742.6 1772.3 1774.4 65975.3 70445.9 71438.6 73106.6 74650.0 9984.2 10139.2 10340.2 10345.5 10436.5 14028.8 14072.5 14111.8 14123.5 14158.4 7029.2 7057.2 7377.0 7440.7 7604.4 6901.4 6903.1 6929.1 7081.6 7268.5 4423.0 4429.3 4430.8 4439.0 4458.6 1516.2 1604.8 1633.1 1788.4 1941.2 812.0 831.6 880.9 903.1 918.1 16995.4 17070.4 17350.7 17522.7 17849.3 940.0 956.2 958.7 962.2 974.4 9533.0 9908.3 9982.0 10015.7 10023.6 388752.0 403837.0 404012.0 404297.0 405925.0 75877.2 79216.6 79326.6 79528.2 81173.0 866.1 883.1 900.0 911.3 913.4 12473.5 15377.7 15671.5 15787.3 15867.4 35412.8 36641.5 37413.0 39093.0 39252.2 48302.5 48536.5 49110.8 49833.0 53524.5 7485.2 7687.2 7819.8 8035.3 8067.5 8237.3 10515.8 11162.3 11259.5 12345.2 10452.8 10639.3 11145.5 11246.3 11307.0 9773.0 10635.9 10659.0 10803.7 11444.8 11171.7 11269.5 11341.8 11392.2 11639.4 7675.9 7743.6 7777.5 7964.3 8336.7 10459.5 10617.7 11223.7 11230.6 11328.1 08:41:34 INFO - PROCESS | 32499 | 08:41:34 INFO - PROCESS | 32499 | [#3] mootools.html Cycles:180 Average:5120.20 Median:4920.41 stddev:2885.89 (58.7%) stddev-sans-first:2880.31 08:41:34 INFO - PROCESS | 32499 | Values: 1381.9 1417.7 1493.7 1705.0 1733.8 6809.1 7518.5 7544.9 8044.8 8106.9 7703.6 7900.7 7934.9 7944.1 7965.0 2216.7 2255.0 2263.2 2264.0 2269.4 2210.5 2237.2 2269.4 2277.7 2281.0 2218.4 2243.1 2255.9 2263.8 2267.2 2185.8 2199.8 2204.5 2215.1 2221.9 2177.2 2187.6 2188.5 2188.5 2194.5 7882.5 7925.0 7930.4 7986.0 7988.1 4600.1 4686.8 4729.8 4736.0 4736.5 2804.9 2910.0 2949.8 2955.3 2958.6 912.3 932.2 953.7 954.1 965.5 10677.8 10696.8 10701.1 10722.3 10793.4 4039.7 4240.5 4301.2 4396.3 4400.8 9220.9 9221.6 9224.1 9229.4 9230.4 4721.5 4723.1 4731.2 4760.2 4774.2 3663.4 4136.6 4254.8 4293.5 4312.2 3649.9 3673.3 3735.9 3775.9 3791.4 1153.3 1164.5 1171.7 1171.9 1173.7 695.9 812.8 819.3 838.3 848.7 4849.2 5192.9 5232.7 5290.9 5316.2 398.4 400.3 411.2 413.0 416.6 3378.9 3466.5 3484.5 3514.6 3559.2 9299.7 9539.2 9578.2 9634.2 9690.1 9542.6 9590.2 9621.2 9625.5 9643.4 7163.8 7246.8 7280.2 7324.6 7342.5 4991.6 5032.3 5057.2 5060.4 5084.6 8523.9 8708.8 8712.9 8719.0 8816.8 8953.4 9009.3 9027.2 9045.8 9054.0 5933.7 6605.4 6758.6 6811.5 6888.9 7599.1 7626.8 7653.6 7666.7 7673.5 6579.7 6676.6 6689.9 6714.7 6875.0 6548.4 6577.9 6671.4 6782.0 6882.5 5999.2 6026.8 6039.1 6089.6 6091.1 4412.2 4414.1 4448.9 4459.7 4528.0 4362.5 4375.7 4462.5 4530.8 4533.3 08:41:34 INFO - PROCESS | 32499 | 08:41:34 INFO - PROCESS | 32499 | [#4] prototype.html Cycles:180 Average:4439.67 Median:5105.73 stddev:1301.82 (25.5%) stddev-sans-first:1267.80 08:41:34 INFO - PROCESS | 32499 | Values: 297.0 304.4 310.7 311.1 312.2 5112.9 5165.3 5165.9 5169.7 5181.0 5047.9 5066.1 5092.7 5097.8 5106.8 3772.6 3921.4 3988.4 3991.8 4042.4 3991.6 3998.7 4001.1 4003.8 4012.7 3988.7 4001.4 4010.8 4016.1 4018.5 3741.8 3897.1 3976.7 3986.3 3989.5 3438.2 3439.7 3448.6 3458.3 3464.6 5028.1 5049.6 5055.1 5055.3 5055.4 4212.0 4525.4 4550.7 4575.2 4584.4 5281.6 5293.3 5309.8 5313.7 5346.0 3742.5 3747.0 3751.9 3754.6 3768.3 5326.9 5667.3 5673.7 5694.7 5706.7 3783.5 3835.2 3852.4 3855.9 3871.6 3874.0 3877.7 3893.5 3894.5 3899.9 4473.3 4482.1 4507.1 4522.1 4535.2 5211.3 5350.5 5362.2 5386.8 5418.0 1333.9 1348.2 1353.4 1355.2 1356.7 816.4 835.6 853.2 873.8 878.3 4597.8 4742.0 4749.9 4753.5 4757.9 5569.1 5593.2 5597.7 5603.3 5611.3 4461.0 4778.6 4784.1 4785.9 4803.2 2897.0 2935.8 2950.2 2951.8 2961.4 5165.8 5176.5 5185.5 5202.4 5202.5 5477.3 5606.6 5646.7 5697.5 5703.5 5143.7 5146.1 5160.9 5162.2 5165.7 5503.2 5544.0 5557.6 5563.8 5578.3 5303.9 5395.5 5413.0 5416.3 5428.3 5127.3 5151.2 5156.5 5163.8 5169.5 3935.7 3969.5 4009.9 4031.0 4041.5 5267.9 5467.8 5505.9 5523.8 5559.1 5278.6 5303.2 5304.0 5316.5 5319.9 5104.6 5303.1 5314.2 5314.6 5324.8 5309.3 5323.0 5325.6 5331.6 5340.8 5059.7 5204.3 5289.8 5335.5 5347.3 5288.2 5295.6 5320.7 5329.3 5341.6 08:41:34 INFO - PROCESS | 32499 | 08:41:34 INFO - PROCESS | 32499 | [#5] yui.html Cycles:180 Average:16317.55 Median:44593.78 stddev:22161.81 (49.7%) stddev-sans-first:22192.73 08:41:34 INFO - PROCESS | 32499 | Values: 643.6 651.9 668.7 738.3 765.5 12166.8 12594.2 12617.6 12648.1 12662.6 11999.0 12078.4 12081.5 12113.9 12169.4 606.8 761.4 765.7 778.8 780.2 780.7 785.1 785.9 786.5 787.3 833.8 836.8 836.8 837.4 837.9 824.5 825.9 826.2 828.2 829.3 605.1 608.9 609.0 610.2 611.2 11916.5 11974.2 12008.8 12015.9 12051.9 13202.5 13550.1 13851.0 13883.4 13936.2 10274.5 10316.6 10359.3 10390.7 10444.5 3256.3 3282.3 3309.4 3355.6 3366.1 60113.7 60513.7 61425.4 61548.4 61748.0 10372.2 10630.6 10669.9 10770.3 11218.6 19624.1 19648.6 19662.9 19667.5 19668.1 6969.3 7008.0 7014.3 7241.1 7269.3 3653.7 3700.6 3710.4 3747.9 3770.8 2852.4 2926.1 2927.4 2936.1 2939.1 485.6 510.8 513.9 515.5 521.9 487.8 488.2 549.3 617.5 629.4 7644.4 8013.8 8164.0 8248.8 8293.0 590.4 592.0 593.9 604.2 605.2 3695.4 3698.2 3800.3 3882.7 3989.3 63138.0 94597.5 96815.5 97842.0 98467.0 43053.0 43678.3 70094.0 76958.2 78244.0 44652.8 63260.7 68424.7 71538.3 74829.0 8586.7 9403.8 9568.6 9629.7 9725.2 42537.6 43550.0 44534.8 45655.5 46220.8 35872.0 40012.6 47530.0 53835.0 55640.0 11519.5 11693.0 11842.5 11871.7 11890.5 13374.1 13505.0 13549.1 13611.9 14347.9 12182.9 12702.5 12960.7 13076.9 13681.2 12422.4 12449.3 12870.7 13020.9 13191.0 11608.6 11812.8 11970.3 12077.6 12142.4 9800.6 9840.4 9926.4 10005.2 10217.6 8668.3 9397.8 9845.3 10027.9 10151.3 08:41:34 INFO - PROCESS | 32499 | -------- Summary: end -------- 08:41:34 INFO - PROCESS | 32499 | 08:41:35 INFO - TEST-INFO | 32499: exit 0 08:41:35 INFO - TEST-OK | dromaeo_css | took 1119472ms 08:41:35 INFO - TEST-START | kraken 08:41:35 INFO - operating with platform_type : linux_ 08:41:35 INFO - Initialising browser for kraken test... 08:41:35 INFO - TEST-INFO | started process 32743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsrU0Vy/profile http://localhost:46970/getInfo.html) 08:41:40 INFO - PROCESS | 32743 | __metrics Screen width/height:1600/1200 08:41:40 INFO - PROCESS | 32743 | colorDepth:24 08:41:40 INFO - PROCESS | 32743 | Browser inner width/height: 1024/697 08:41:40 INFO - PROCESS | 32743 | __metrics 08:41:40 ERROR - PROCESS | 32743 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 08:41:41 INFO - TEST-INFO | 32743: exit 0 08:41:41 INFO - Browser initialized. 08:41:41 INFO - Running cycle 1/1 for kraken test... 08:41:41 INFO - TEST-INFO | started process 400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsrU0Vy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:53 INFO - PROCESS | 400 | RSS: Main: 168161280 08:41:53 INFO - PROCESS | 400 | 08:41:56 INFO - PROCESS | 400 | Cycle 1(1): loaded http://localhost:46970/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46970/tests/kraken/driver.html?testName=audio-beat-detection) 08:41:57 INFO - PROCESS | 400 | RSS: Main: 173461504 08:41:57 INFO - PROCESS | 400 | 08:41:59 INFO - PROCESS | 400 | Cycle 1(1): loaded http://localhost:46970/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46970/tests/kraken/driver.html?testName=audio-dft) 08:42:00 INFO - PROCESS | 400 | RSS: Main: 172806144 08:42:00 INFO - PROCESS | 400 | 08:42:03 INFO - PROCESS | 400 | Cycle 1(1): loaded http://localhost:46970/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46970/tests/kraken/driver.html?testName=audio-fft) 08:42:04 INFO - PROCESS | 400 | RSS: Main: 168833024 08:42:04 INFO - PROCESS | 400 | 08:42:06 INFO - PROCESS | 400 | Cycle 1(1): loaded http://localhost:46970/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46970/tests/kraken/driver.html?testName=audio-oscillator) 08:42:07 INFO - PROCESS | 400 | RSS: Main: 169893888 08:42:07 INFO - PROCESS | 400 | 08:42:09 INFO - PROCESS | 400 | Cycle 1(1): loaded http://localhost:46970/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46970/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:42:09 INFO - PROCESS | 400 | RSS: Main: 169906176 08:42:09 INFO - PROCESS | 400 | 08:42:13 INFO - PROCESS | 400 | Cycle 1(1): loaded http://localhost:46970/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46970/tests/kraken/driver.html?testName=imaging-darkroom) 08:42:13 INFO - PROCESS | 400 | RSS: Main: 170160128 08:42:13 INFO - PROCESS | 400 | 08:42:17 INFO - PROCESS | 400 | Cycle 1(1): loaded http://localhost:46970/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46970/tests/kraken/driver.html?testName=imaging-desaturate) 08:42:17 INFO - PROCESS | 400 | RSS: Main: 167456768 08:42:17 INFO - PROCESS | 400 | 08:42:20 INFO - PROCESS | 400 | Cycle 1(1): loaded http://localhost:46970/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46970/tests/kraken/driver.html?testName=json-parse-financial) 08:42:21 INFO - PROCESS | 400 | RSS: Main: 169168896 08:42:21 INFO - PROCESS | 400 | 08:42:23 INFO - PROCESS | 400 | Cycle 1(1): loaded http://localhost:46970/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46970/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:42:23 INFO - PROCESS | 400 | RSS: Main: 169271296 08:42:23 INFO - PROCESS | 400 | 08:42:25 INFO - PROCESS | 400 | Cycle 1(1): loaded http://localhost:46970/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46970/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:42:26 INFO - PROCESS | 400 | RSS: Main: 169791488 08:42:26 INFO - PROCESS | 400 | 08:42:28 INFO - PROCESS | 400 | Cycle 1(1): loaded http://localhost:46970/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46970/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:42:29 INFO - PROCESS | 400 | RSS: Main: 170393600 08:42:29 INFO - PROCESS | 400 | 08:42:32 INFO - PROCESS | 400 | Cycle 1(1): loaded http://localhost:46970/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46970/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:42:32 INFO - PROCESS | 400 | RSS: Main: 170569728 08:42:32 INFO - PROCESS | 400 | 08:42:35 INFO - PROCESS | 400 | Cycle 1(1): loaded http://localhost:46970/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46970/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:42:36 INFO - PROCESS | 400 | RSS: Main: 170237952 08:42:36 INFO - PROCESS | 400 | 08:42:37 INFO - PROCESS | 400 | Cycle 1(1): loaded http://localhost:46970/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46970/tests/kraken/driver.html?testName=ai-astar) 08:42:38 INFO - PROCESS | 400 | RSS: Main: 171241472 08:42:38 INFO - PROCESS | 400 | 08:42:38 INFO - PROCESS | 400 | __start_tp_report 08:42:38 INFO - PROCESS | 400 | _x_x_mozilla_page_load 08:42:38 INFO - PROCESS | 400 | _x_x_mozilla_page_load_details 08:42:38 INFO - PROCESS | 400 | |i|pagename|runs| 08:42:38 INFO - PROCESS | 400 | |0;ai-astar;105;115;109;115;114;116;116;115;115;114 08:42:38 INFO - PROCESS | 400 | |1;audio-beat-detection;151;125;149;189;124;155;159;128;197;125 08:42:38 INFO - PROCESS | 400 | |2;audio-dft;166;164;165;184;163;165;164;163;164;163 08:42:38 INFO - PROCESS | 400 | |3;audio-fft;77;78;76;156;77;76;75;76;161;76 08:42:38 INFO - PROCESS | 400 | |4;audio-oscillator;86;86;149;85;86;84;133;86;86;136 08:42:38 INFO - PROCESS | 400 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;119;117 08:42:38 INFO - PROCESS | 400 | |6;imaging-darkroom;149;149;155;149;148;149;148;148;148;149 08:42:38 INFO - PROCESS | 400 | |7;imaging-desaturate;95;95;96;96;95;96;95;95;96;96 08:42:38 INFO - PROCESS | 400 | |8;json-parse-financial;62;63;63;62;69;63;63;64;62;63 08:42:38 INFO - PROCESS | 400 | |9;json-stringify-tinderbox;65;66;65;66;65;66;65;66;67;66 08:42:38 INFO - PROCESS | 400 | |10;stanford-crypto-aes;86;80;79;86;85;79;85;79;84;85 08:42:38 INFO - PROCESS | 400 | |11;stanford-crypto-ccm;147;146;134;140;134;141;131;133;173;152 08:42:38 INFO - PROCESS | 400 | |12;stanford-crypto-pbkdf2;168;166;166;166;162;165;166;165;165;165 08:42:38 INFO - PROCESS | 400 | |13;stanford-crypto-sha256-iterative;70;69;70;69;68;67;67;67;70;66 08:42:38 INFO - PROCESS | 400 | __end_tp_report 08:42:38 INFO - PROCESS | 400 | __start_cc_report 08:42:38 INFO - PROCESS | 400 | _x_x_mozilla_cycle_collect,1004 08:42:38 INFO - PROCESS | 400 | __end_cc_report 08:42:38 INFO - PROCESS | 400 | __startTimestamp1469029358241__endTimestamp 08:42:38 INFO - PROCESS | 400 | 08:42:38 INFO - PROCESS | 400 | ------- Summary: start ------- 08:42:38 INFO - PROCESS | 400 | Number of tests: 14 08:42:38 INFO - PROCESS | 400 | 08:42:38 INFO - PROCESS | 400 | [#0] ai-astar Cycles:10 Average:113.40 Median:115.00 stddev:3.57 (3.1%) stddev-sans-first:2.12 08:42:38 INFO - PROCESS | 400 | Values: 105.0 115.0 109.0 115.0 114.0 116.0 116.0 115.0 115.0 114.0 08:42:38 INFO - PROCESS | 400 | 08:42:38 INFO - PROCESS | 400 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:153.00 stddev:26.35 (17.2%) stddev-sans-first:27.94 08:42:38 INFO - PROCESS | 400 | Values: 151.0 125.0 149.0 189.0 124.0 155.0 159.0 128.0 197.0 125.0 08:42:38 INFO - PROCESS | 400 | 08:42:38 INFO - PROCESS | 400 | [#2] audio-dft Cycles:10 Average:166.10 Median:164.50 stddev:6.37 (3.9%) stddev-sans-first:6.75 08:42:38 INFO - PROCESS | 400 | Values: 166.0 164.0 165.0 184.0 163.0 165.0 164.0 163.0 164.0 163.0 08:42:38 INFO - PROCESS | 400 | 08:42:38 INFO - PROCESS | 400 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.00 stddev:34.66 (45.6%) stddev-sans-first:36.28 08:42:38 INFO - PROCESS | 400 | Values: 77.0 78.0 76.0 156.0 77.0 76.0 75.0 76.0 161.0 76.0 08:42:38 INFO - PROCESS | 400 | 08:42:38 INFO - PROCESS | 400 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:86.00 stddev:26.28 (30.6%) stddev-sans-first:27.26 08:42:38 INFO - PROCESS | 400 | Values: 86.0 86.0 149.0 85.0 86.0 84.0 133.0 86.0 86.0 136.0 08:42:38 INFO - PROCESS | 400 | 08:42:38 INFO - PROCESS | 400 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 08:42:38 INFO - PROCESS | 400 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 119.0 117.0 08:42:38 INFO - PROCESS | 400 | 08:42:38 INFO - PROCESS | 400 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.00 stddev:2.10 (1.4%) stddev-sans-first:2.22 08:42:38 INFO - PROCESS | 400 | Values: 149.0 149.0 155.0 149.0 148.0 149.0 148.0 148.0 148.0 149.0 08:42:38 INFO - PROCESS | 400 | 08:42:38 INFO - PROCESS | 400 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:42:38 INFO - PROCESS | 400 | Values: 95.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 08:42:38 INFO - PROCESS | 400 | 08:42:38 INFO - PROCESS | 400 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.00 stddev:2.07 (3.3%) stddev-sans-first:2.13 08:42:38 INFO - PROCESS | 400 | Values: 62.0 63.0 63.0 62.0 69.0 63.0 63.0 64.0 62.0 63.0 08:42:38 INFO - PROCESS | 400 | 08:42:38 INFO - PROCESS | 400 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 08:42:38 INFO - PROCESS | 400 | Values: 65.0 66.0 65.0 66.0 65.0 66.0 65.0 66.0 67.0 66.0 08:42:38 INFO - PROCESS | 400 | 08:42:38 INFO - PROCESS | 400 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:85.00 stddev:3.12 (3.7%) stddev-sans-first:3.09 08:42:38 INFO - PROCESS | 400 | Values: 86.0 80.0 79.0 86.0 85.0 79.0 85.0 79.0 84.0 85.0 08:42:38 INFO - PROCESS | 400 | 08:42:38 INFO - PROCESS | 400 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:143.50 stddev:12.58 (8.8%) stddev-sans-first:13.27 08:42:38 INFO - PROCESS | 400 | Values: 147.0 146.0 134.0 140.0 134.0 141.0 131.0 133.0 173.0 152.0 08:42:38 INFO - PROCESS | 400 | 08:42:38 INFO - PROCESS | 400 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.40 Median:166.00 stddev:1.51 (0.9%) stddev-sans-first:1.27 08:42:38 INFO - PROCESS | 400 | Values: 168.0 166.0 166.0 166.0 162.0 165.0 166.0 165.0 165.0 165.0 08:42:38 INFO - PROCESS | 400 | 08:42:38 INFO - PROCESS | 400 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:1.49 (2.2%) stddev-sans-first:1.45 08:42:38 INFO - PROCESS | 400 | Values: 70.0 69.0 70.0 69.0 68.0 67.0 67.0 67.0 70.0 66.0 08:42:38 INFO - PROCESS | 400 | -------- Summary: end -------- 08:42:38 INFO - PROCESS | 400 | 08:42:39 INFO - TEST-INFO | 400: exit 0 08:42:39 INFO - TEST-OK | kraken | took 64184ms 08:42:39 INFO - SUITE-END | took 1183s 08:42:39 INFO - Completed test suite (00:19:43) 08:42:39 INFO - javascript benchmark 08:42:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6523.48404357146, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2631.329011102169, 2636.340914771308, 2647.682278126625, 2676.384431580735, 2680.9061682841093, 4927.113119638464, 5004.599632029438, 5015.172496538076, 5015.5486006259425, 5021.071101846161, 4772.761361931907, 4805.0, 4834.927476087862, 4867.537583929521, 4873.805047798092, 4444.622207112399, 4484.394606728099, 4510.188166130095, 4568.063546972862, 4572.565606267399, 4484.1928452878465, 4499.122671079141, 4525.411696479453, 4536.138133754593, 4618.12255671423, 4472.805343511459, 4591.44902611687, 4664.5102264262105, 4679.227927391977, 4680.391549098613, 4553.567411095941, 4593.494715581283, 4600.539946005372, 4605.976970115128, 4622.8150873965005, 4298.828046878121, 4406.7355958642265, 4428.40216570762, 4438.800253988578, 4466.642668586538, 4755.2153894607345, 4780.49804770501, 4814.807407703687, 4881.951180488185, 4936.111499930011, 5188.7146206958605, 5200.97399513, 5214.765335559871, 5235.869103272411, 5285.550728188108, 5297.152455607123, 5327.200919862013, 5339.546138578186, 5367.892642147135, 5370.113931201347, 4944.431390390151, 4978.527039931273, 4982.252662100642, 4982.825601104017, 4986.401631804134, 5254.343207099113, 5414.242006119146, 5472.91790623141, 5480.232767412565, 5481.479259470344, 5211.739413029333, 5235.502627250406, 5253.737313134328, 5304.779900622878, 5307.28351672527, 5348.652337598043, 5354.491323324278, 5373.596980226421, 5376.596755243372, 5413.323334583177, 5104.1578139606545, 5153.845384638392, 5264.736763161826, 5276.287701160294, 5278.366596008504, 5164.948350516522, 5180.404253510819, 5184.196449550326, 5196.9865876154545, 5216.504432078947, 4427.29163333865, 4430.014142581131, 4436.0462500562535, 4442.111577684476, 4487.41663583732, 3785.8296376663116, 3793.8103094845146, 3819.0452386903276, 3869.496965394537, 3877.922441551153, 4577.717521333395, 4597.977010114928, 4598.3102534620075, 4617.907641847144, 4640.83757068501, 5259.132243179909, 5308.044551980681, 5312.335958005249, 5314.681119132864, 5355.705436201047, 4417.491988421309, 4530.524294948983, 4555.703879247838, 4588.49526552079, 4638.234691275969, 4712.95287047132, 4729.290606409066, 4737.928931066037, 4770.403699537558, 4783.378160839138, 4937.901241975069, 4938.407391113089, 4941.431735350337, 4953.876153096201, 4979.3526841510375, 5152.845414637567, 5177.4822517747925, 5249.658772179796, 5303.36359636846, 5352.652077615098, 4920.92618610714, 4943.382077240345, 4948.307236986752, 4977.228529577921, 4982.775775090057, 5162.328897243335, 5189.040027594907, 5189.948100519097, 5201.609879258995, 5251.343582052244, 5158.509941555546, 5211.609129315392, 5213.791448342024, 5245.868853278546, 5270.578353731769, 5082.4409314976065, 5083.313752643346, 5099.260607212008, 5138.4604616514725, 5147.871303217449, 5077.644564880571, 5094.7962081516325, 5099.617528685438, 5117.02776472469, 5142.5885929126325, 4874.049560335842, 4923.926141107814, 4924.4090709115135, 4968.950310496849, 4983.127952608206, 4983.352164218629, 5004.799808007639, 5091.312672789274, 5103.311053007945, 5129.076766182123, 5070.340855688737, 5109.259157422079, 5126.436092029949, 5162.767675454688, 5183.688978661293], "value": 4824.6218008371925, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.6653141583633, 569.5045310579796, 581.6248519704787, 582.9795957141499, 605.1769593353036, 37269.627303726986, 40595.39106913395, 40797.79601101994, 40871.386929196015, 40901.38647920276, 39983.0, 40341.19317613646, 40415.59584404155, 40520.79739601298, 40532.39201411974, 7899.723509677163, 8023.0, 8028.0, 8032.3172530335, 8045.436819422614, 7857.646405911748, 7927.722529711461, 7928.0, 7939.36485081195, 7948.125706172316, 7934.285914267714, 7973.880391794099, 8006.039275286945, 8014.238647328523, 8024.719134830282, 7798.7270445534705, 7901.130875603708, 7931.365490760783, 7941.920580794176, 7961.601919904039, 7817.491863028885, 7907.209279072104, 7932.325752311061, 7966.721164759264, 7975.082865470487, 38628.0, 38772.41841372382, 38885.41671874924, 38886.0, 39060.0, 3099.2406860319143, 3180.4434224010706, 3327.633960264369, 3443.6900678939014, 3833.5016447861876, 28045.43909121806, 29907.0, 30694.079177624706, 30749.0, 30796.692033079606, 3515.630858759819, 3544.964550354515, 3602.0, 3700.1859590889962, 3719.590845007074, 271074.0, 274703.0, 275404.0, 276593.0, 278281.6085919578, 57135.0, 57225.71387143037, 57480.425195747506, 57575.71212143996, 57618.423815762144, 33599.824006159666, 34525.30949380998, 34620.82689586536, 36267.63732362695, 52973.205401919, 15521.611959700873, 15683.921580392025, 15693.921530392276, 15707.293171807296, 15720.92139539295, 11933.0, 12024.699382515331, 12028.27830330183, 12028.939855300667, 12030.939845300718, 18630.254789808256, 18982.905085474762, 19014.954177520092, 19036.42890713281, 19070.42788716313, 6680.298568650319, 6767.492438067165, 6793.898091528631, 6830.351116643911, 6927.203371612329, 828.8093738440072, 937.6811883959487, 1023.2428003277521, 1028.3264461777549, 1049.8740151181755, 29324.0, 29589.408211836075, 29754.553681694793, 29838.55242171369, 30053.248668783457, 897.7306807957586, 939.0843927170954, 946.4226821638932, 1043.7234132954773, 1057.318029870729, 14672.486462973744, 14907.403703851942, 15203.087814731152, 15295.617609559627, 15528.922355388377, 405663.0, 406588.0, 407186.0, 409338.0, 410301.0, 51307.23039154341, 51665.60842328369, 51719.48280517222, 51801.7409912948, 52077.479225207266, 1148.9942550287194, 1190.7975644140517, 1192.3442106841376, 1197.8981786548068, 1203.6810245285008, 26928.192154235403, 28004.0, 28336.85831570829, 28713.28216794597, 29088.7091129086, 43637.78181109074, 43779.78110109429, 44011.77994110009, 44208.33687494626, 44225.55774442343, 346007.0, 347419.0, 347713.0, 348003.0, 348443.0, 25925.481490369708, 25993.480130397664, 26411.73588264093, 26441.471170576864, 26455.735442645328, 43312.133757325304, 43525.12949740924, 43611.78194109009, 43837.0, 43998.560014399445, 36616.26767464689, 37608.43587346137, 38111.42832857454, 38390.616093838704, 38830.61169388383, 37296.44055339226, 37889.43165852459, 37926.24147517089, 38284.617153828105, 38765.80617097009, 37104.91845897003, 37480.250394992494, 38223.80888095542, 38448.23103537969, 41187.588124118374, 31113.37773244568, 34138.65861341355, 34674.133146671535, 34726.65273347234, 35278.0, 26349.20952371432, 26463.867680661475, 26622.866885666223, 26647.33381665474, 26892.462150756484], "value": 18033.144725879793, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.9747317687763, 370.0729672171212, 370.91839795245056, 377.9417630634227, 384.3619591478145, 16124.758128628066, 16932.83067169328, 17473.213705383256, 17501.7374739379, 17502.649947001068, 16646.83353166468, 17187.656246875085, 17617.471475855713, 17731.113444327766, 17785.110744462756, 5006.849794506162, 5228.111221092423, 5230.110881150214, 5230.529252367286, 5244.685318880879, 3787.2236191580796, 5140.7172605506685, 5826.213461182729, 6051.606645568024, 6086.421789929949, 6122.1735065766, 6128.295246046695, 6133.938660613404, 6136.96931515344, 6157.291911430176, 5019.272205530196, 5252.921206181911, 5299.33758280215, 5367.704776237305, 5393.541548968303, 5078.7968481260705, 5108.923366149511, 5132.999065182291, 5148.099082660557, 5224.63427560071, 18813.623727525373, 19780.0, 19926.30257940965, 20829.37511874631, 21237.0, 1786.214065811039, 1862.469196279054, 2071.927482538104, 2120.8409369297365, 2334.6147885598857, 9738.220942324597, 9913.405195688281, 9986.450745209011, 11829.704257393549, 13286.933565332112, 1624.3259047495276, 1736.557177919635, 1742.5904912345588, 1772.3176577017812, 1774.3700986149988, 65975.3402465974, 70445.94331085037, 71438.64280678563, 73106.63446682786, 74650.0, 9984.20126389887, 10139.239557033105, 10340.172786177087, 10345.482725863827, 10436.478176091165, 14028.789568156486, 14072.507462238773, 14111.78832317516, 14123.505677301246, 14158.433662653584, 7029.22678505364, 7057.153141623038, 7376.96311518439, 7440.702371905063, 7604.391648668204, 6901.413379862768, 6903.1371078615175, 6929.099217101744, 7081.610511421818, 7268.45486588508, 4422.982713975739, 4429.313456414261, 4430.822767089345, 4439.0, 4458.5987261146, 1516.2115699836245, 1604.7833542471617, 1633.1426001349387, 1788.4098247578268, 1941.1652989214774, 811.9553424561587, 831.584207896052, 880.903100658927, 903.1239697493421, 918.083981460436, 16995.40516081956, 17070.43943408474, 17350.65298694019, 17522.737158942626, 17849.28602855897, 939.9953000234955, 956.1729104324849, 958.7219706285099, 962.2350231565922, 974.444566597047, 9533.0, 9908.256880733974, 9982.0, 10015.69952901414, 10023.599056037823, 388752.0, 403837.0, 404012.0, 404297.0, 405925.0, 75877.24122758702, 79216.60391698005, 79326.60336698279, 79528.20471795324, 81173.0, 866.120887299379, 883.0595415882065, 899.9685011024714, 911.284641556375, 913.4017218721748, 12473.501059957864, 15377.692446151239, 15671.451499197474, 15787.289571969059, 15867.365305387655, 35412.82293588515, 36641.45037824381, 37413.0, 39093.02267443223, 39252.214955700154, 48302.5169748298, 48536.5146348532, 49110.75444622754, 49833.0, 53524.4647553535, 7485.1766305707415, 7687.154413014676, 7819.84360312802, 8035.316998055231, 8067.515949043076, 8237.258646721824, 10515.78968420612, 11162.274452160584, 11259.49332280033, 12345.209944558168, 10452.843207351743, 10639.255252132276, 11145.49845256949, 11246.325220486797, 11307.0, 9772.951135244279, 10635.94682026585, 10659.0, 10803.729906752395, 11444.828327574927, 11171.66485005451, 11269.49287282058, 11341.773164536828, 11392.202545822045, 11639.359835209145, 7675.884861726967, 7743.612819359122, 7777.494462859896, 7964.283214510722, 8336.666533338599, 10459.529321180413, 10617.734556636145, 11223.66329010131, 11230.55077796879, 11328.0742273812], "value": 8383.4419871354, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1381.861813818618, 1417.7377185220732, 1493.7311283968882, 1704.9744253836202, 1733.7659415978846, 6809.080774095496, 7518.511296765706, 7544.886826697591, 8044.8391032179325, 8106.878396824052, 7703.614819259029, 7900.723474678387, 7934.880976785353, 7944.126146123922, 7965.04419469663, 2216.7229096362953, 2254.954900901981, 2263.151318255654, 2263.9773602264013, 2269.4439862233776, 2210.4805370737863, 2237.161064600775, 2269.353234328217, 2277.7038984931937, 2280.9543809123807, 2218.3566765637947, 2243.0915479230857, 2255.8533695309834, 2263.7962583367494, 2267.161150374364, 2185.825133989277, 2199.8130158936588, 2204.4599073227, 2215.1139544182297, 2221.9333419997424, 2177.1835561664375, 2187.595294870438, 2188.4638263625357, 2188.5075857931997, 2194.4513871532117, 7882.5270483771155, 7924.960375198087, 7930.405219608552, 7986.041674998979, 7988.081370642392, 4600.05698831742, 4686.812527498896, 4729.763511824395, 4736.0, 4736.455307639631, 2804.859757012141, 2909.970900291012, 2949.7935144539892, 2955.335049613841, 2958.5562165675105, 912.2884150362728, 932.244881645869, 953.7329547726648, 954.1079091049891, 965.5268918230087, 10677.83983240252, 10696.839547406795, 10701.090407315387, 10722.303050301784, 10793.406362650052, 4039.717219794586, 4240.469941257343, 4301.247281725686, 4396.296592545177, 4400.845970391021, 9220.907790922005, 9221.585028673726, 9224.077592240723, 9229.35394522377, 9230.400023998418, 4721.480637129913, 4723.055388922229, 4731.219348807408, 4760.238361862085, 4774.21225497789, 3663.377225871608, 4136.627703506639, 4254.808533615995, 4293.484781826201, 4312.180685669713, 3649.8905032849057, 3673.3020726061964, 3735.9439608405896, 3775.9433608495897, 3791.3933770596573, 1153.3195414705365, 1164.4876254448016, 1171.654361963223, 1171.9062475001979, 1173.747644256489, 695.9478039147084, 812.8049268175595, 819.3199644295221, 838.3209600223838, 848.6732607945985, 4849.248366503198, 5192.896142077213, 5232.73836308183, 5290.947090529045, 5316.229146773773, 398.44615983782563, 400.2635151321582, 411.2248411743884, 412.9938050929238, 416.6063070398444, 3378.9324213515592, 3466.4973578830927, 3484.4773284007097, 3514.5606799150105, 3559.2169722660974, 9299.67451139207, 9539.189168920719, 9578.233741300679, 9634.181094606896, 9690.12788849007, 9542.61829526825, 9590.184834289024, 9621.230301575857, 9625.51872406377, 9643.373180743229, 7163.820904477326, 7246.782596522113, 7280.199178090405, 7324.560526368435, 7342.48602597813, 4991.575716064175, 5032.3206367139965, 5057.216131499624, 5060.3927528696795, 5084.618653600921, 8523.872141918, 8708.78228044304, 8712.869306960274, 8719.0, 8816.823663526566, 8953.418027828171, 9009.324300677345, 9027.232685221566, 9045.819083618422, 9054.0, 5933.703314834327, 6605.372489613479, 6758.594484330956, 6811.489138314745, 6888.931110688829, 7599.088109426904, 7626.847463050597, 7653.57905315213, 7666.69333226687, 7673.462857600138, 6579.736810527525, 6676.632785196666, 6689.866202676017, 6714.664266786739, 6875.0, 6548.443382312366, 6577.934220657924, 6671.39957403836, 6782.0, 6882.483813713891, 5999.1901093351835, 6026.758929642765, 6039.124326972652, 6089.604175728564, 6091.086337049478, 4412.205802955499, 4414.117176564636, 4448.9110217796115, 4459.732416055047, 4527.977360113178, 4362.454693163355, 4375.6718246132305, 4462.509123996293, 4530.818767249405, 4533.274676051816], "value": 4059.4873596605507, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.9777266704997, 304.36387949186195, 310.7374268742912, 311.08851066375513, 312.1649587353828, 5112.8977420451565, 5165.251038599406, 5165.896682066356, 5169.715665638389, 5180.974095129519, 5047.949520504794, 5066.138756411409, 5092.694438333702, 5097.770600322985, 5106.846794596158, 3772.566154892188, 3921.3529767588316, 3988.3818008208773, 3991.800409979504, 4042.43405923171, 3991.560928297885, 3998.7200895937294, 4001.1397549526846, 4003.779792111433, 4012.6589239914642, 3988.7036713068223, 4001.379786133154, 4010.7794071326066, 4016.116454380032, 4018.5177778666457, 3741.8129093545213, 3897.0647044709067, 3976.6818654507715, 3986.3023970804993, 3989.501312335958, 3438.157651375404, 3439.6560343965652, 3448.5689288838894, 3458.342914846171, 3464.6015708193627, 5028.145215313405, 5049.64652474327, 5055.115354812893, 5055.317532133152, 5055.368078990126, 4211.978940105279, 4525.411696479469, 4550.749708766017, 4575.22221222393, 4584.381108550369, 5281.63028587999, 5293.311869456985, 5309.787608495655, 5313.734313284359, 5345.973270133663, 3742.4573436851506, 3746.9625303747157, 3751.906202344936, 3754.554496518833, 3768.3405404054456, 5326.92009619856, 5667.319921609434, 5673.716314184274, 5694.718688295142, 5706.657600543981, 3783.4703141559653, 3835.1562656215588, 3852.3836186210074, 3855.8843234703004, 3871.632194941476, 3873.96126038736, 3877.65101140893, 3893.493845800028, 3894.4937158169255, 3899.922001559953, 4473.261911784584, 4482.148391805546, 4507.11544611449, 4522.140793249272, 4535.16099521583, 5211.348581427322, 5350.4649535046965, 5362.2224777407055, 5386.8383948481605, 5417.970585588804, 1333.852886517594, 1348.191085348783, 1353.41126609925, 1355.2342926246836, 1356.7083077138464, 816.4366587054913, 835.6114406800867, 853.2320911179863, 873.750980970433, 878.3456325037888, 4597.839075632337, 4741.976290118596, 4749.881252968704, 4753.453352864396, 4757.881052973703, 5569.053260945649, 5593.20339830085, 5597.74810133545, 5603.299587551556, 5611.270534830527, 4460.955390446119, 4778.593819525379, 4784.091022705675, 4785.904281914342, 4803.18345881201, 2896.9710302897124, 2935.77981651377, 2950.1886981080374, 2951.778616603763, 2961.4077184563175, 5165.845024649267, 5176.534111929945, 5185.507376799198, 5202.401723801811, 5202.453742357074, 5477.3427188737605, 5606.635568688022, 5646.661200327993, 5697.487226149667, 5703.460065782216, 5143.717095559706, 5146.099432599355, 5160.948390516047, 5162.174052151638, 5165.74171291434, 5503.229547863222, 5544.0, 5557.583181261502, 5563.833085007456, 5578.30271216098, 5303.946960530346, 5395.4604539545735, 5412.972935135299, 5416.322959630046, 5428.348598168245, 5127.307813445286, 5151.175811870233, 5156.458571849902, 5163.845084647466, 5169.53474187325, 3935.7048221384084, 3969.523657161159, 4009.939850902297, 4031.0, 4041.4948131483566, 5267.894642107213, 5467.835964921059, 5505.889882202414, 5523.751431185687, 5559.11054231321, 5278.5513231374225, 5303.15149576066, 5304.045271851104, 5316.468353164652, 5319.920201196907, 5104.617153713412, 5303.098473259478, 5314.202869569595, 5314.5650674318495, 5324.787008519771, 5309.256704061511, 5323.0, 5325.627206095536, 5331.600129990344, 5340.810267790343, 5059.723124593874, 5204.323437953042, 5289.788408463773, 5335.493128152819, 5347.251384806053, 5288.206768984683, 5295.576353891603, 5320.680759154463, 5329.307190065267, 5341.599380046434], "value": 4018.566501832522, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.6170478565253, 651.9348065193478, 668.6656671664165, 738.3198987674743, 765.4985984180361, 12166.81749773753, 12594.181378210433, 12617.55838545651, 12648.051396145303, 12662.556810511634, 11999.040076793857, 12078.396080195998, 12081.456334464949, 12113.878861211408, 12169.391530423465, 606.7633622887056, 761.3908872901684, 765.6975494679598, 778.7897267737736, 780.157429975625, 780.7150390107598, 785.0775338976708, 785.8899754034439, 786.4927122006302, 787.3425689549233, 833.7748807821885, 836.8033512124646, 836.8284501677142, 837.3636036612188, 837.857564214082, 824.4599787139433, 825.8926339575877, 826.2274773087153, 828.225609055535, 829.3158144530786, 605.0984033789666, 608.9299730531002, 609.0468416927495, 610.1518888744648, 611.1688104178314, 11916.523339066427, 11974.161808673396, 12008.759824803543, 12015.85849344311, 12051.939740301243, 13202.471901123943, 13550.119242249222, 13851.0, 13883.4446622135, 13936.163830170222, 10274.486275686186, 10316.638917637847, 10359.32664376813, 10390.740231494197, 10444.529996150115, 3256.348730253959, 3282.2943067240417, 3309.38776326378, 3355.580552430946, 3366.0575038989123, 60113.699431503, 60513.69743151256, 61425.38574614286, 61548.38451615516, 61748.0, 10372.222083343779, 10630.627928022637, 10669.89330106689, 10770.299930504649, 11218.551257949754, 19624.116914738872, 19648.60702785936, 19662.901685491768, 19667.508312292306, 19668.11493482797, 6969.2682268362105, 7008.0, 7014.263502332182, 7241.131064272216, 7269.345758881726, 3653.707703383723, 3700.555933287969, 3710.3692372296773, 3747.8500859965297, 3770.792606406619, 2852.35821940066, 2926.1367896470592, 2927.4145170965894, 2936.0604606526135, 2939.0595009596723, 485.6115107913655, 510.79312878284355, 513.8715321169708, 515.5334422347781, 521.890403015371, 487.77318546875875, 488.16280079663545, 549.2749570566893, 617.4936552027294, 629.380060640269, 7644.388448924073, 8013.7996550085545, 8164.0, 8248.793780155544, 8293.004839419309, 590.35356284868, 591.961522501036, 593.8990371636833, 604.1994357476361, 605.1618508365857, 3695.3533131701843, 3698.204885949534, 3800.315943130208, 3882.6699730522655, 3989.2819292527624, 63138.0, 94597.52701236587, 96815.51592241993, 97842.0, 98467.0, 43053.0, 43678.344824827655, 70094.0, 76958.23041769622, 78244.0, 44652.77673611611, 63260.68369658214, 68424.65787671029, 71538.2846171542, 74829.0, 8586.742397728078, 9403.811923761623, 9568.56941437623, 9629.662961796303, 9725.173360264456, 42537.574624253364, 43550.0, 44534.77732611316, 45655.543444565126, 46220.76889615531, 35872.0, 40012.59987400205, 47530.049399011135, 53835.0, 55640.0, 11519.481623327138, 11693.0, 11842.46708898119, 11871.703207419883, 11890.524379024742, 13374.063815533209, 13505.0, 13549.051566390259, 13611.863881361456, 14347.92826035863, 12182.939085304517, 12702.491900323883, 12960.675983100498, 13076.934615326862, 13681.247531385869, 12422.440990155645, 12449.315287658903, 12870.67823304425, 13020.934895325463, 13191.0, 11608.593699220486, 11812.76374472523, 11970.281783093042, 12077.57728479499, 12142.392880356123, 9800.607975680892, 9840.3603765755, 9926.354786938826, 10005.153208863647, 10217.591296348062, 8668.26319762802, 9397.812043759222, 9845.261605379483, 10027.899721002697, 10151.340162889388], "value": 6476.339526452809, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1574.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 109.0, 115.0, 114.0, 116.0, 116.0, 115.0, 115.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 149.0, 189.0, 124.0, 155.0, 159.0, 128.0, 197.0, 125.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 165.0, 184.0, 163.0, 165.0, 164.0, 163.0, 164.0, 163.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 76.0, 156.0, 77.0, 76.0, 75.0, 76.0, 161.0, 76.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 149.0, 85.0, 86.0, 84.0, 133.0, 86.0, 86.0, 136.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 155.0, 149.0, 148.0, 149.0, 148.0, 148.0, 148.0, 149.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 69.0, 63.0, 63.0, 64.0, 62.0, 63.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 67.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 79.0, 86.0, 85.0, 79.0, 85.0, 79.0, 84.0, 85.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 134.0, 140.0, 134.0, 141.0, 131.0, 133.0, 173.0, 152.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 166.0, 166.0, 162.0, 165.0, 166.0, 165.0, 165.0, 165.0], "value": 165.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 70.0, 69.0, 68.0, 67.0, 67.0, 67.0, 70.0, 66.0], "value": 68.3, "unit": "score"}]}]} 08:42:39 INFO - Return code: 0 08:42:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:42:39 ERROR - # TBPL SUCCESS # 08:42:39 INFO - Running post-action listener: _resource_record_post_action 08:42:39 INFO - [mozharness: 2016-07-20 15:42:39.541972Z] Finished run-tests step (success) 08:42:39 INFO - Running post-run listener: _resource_record_post_run 08:42:39 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 547065856; Read time: 0; Write time: 566460 08:42:39 INFO - TinderboxPrint: CPU usage
13.3% 08:42:39 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:42:39 INFO - TinderboxPrint: I/O write bytes / time
547,065,856 / 566,460 08:42:39 INFO - TinderboxPrint: CPU idle
8,297.8 (86.6%) 08:42:39 INFO - TinderboxPrint: CPU user
1,221.2 (12.8%) 08:42:39 INFO - TinderboxPrint: Swap in / out
0 / 0 08:42:39 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256221184; Read time: 0; Write time: 285012 08:42:39 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 290308096; Read time: 0; Write time: 281448 08:42:40 INFO - Running post-run listener: _upload_blobber_files 08:42:40 INFO - Blob upload gear active. 08:42:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:42:40 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 08:42:40 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:42:40 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:42:40 INFO - (blobuploader) - INFO - Open directory for files ... 08:42:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:42:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:43:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:05 INFO - (blobuploader) - INFO - Done attempting. 08:43:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:43:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:43:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:06 INFO - (blobuploader) - INFO - Done attempting. 08:43:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:43:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:43:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:06 INFO - (blobuploader) - INFO - Done attempting. 08:43:06 INFO - (blobuploader) - INFO - Iteration through files over. 08:43:06 INFO - Return code: 0 08:43:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:43:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:43:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/294822e694c665bccb39e175c20d9d8ec0a1142cd3bff755f0187f76302c9f0ef25790304f0dcab171cb3d0d0257f644f89b82eb7c3d048d5b128fbca9d88ae7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8f39b99e91b477fe8da3d22e2ddffc7b213b2fedb32f9a5b05b30fb4ef495eb1521bc9a97c573ab4d4bb98aea167ddf6494f5d8210615a73a220535f385d8f71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/04d388e5559c0f2147d9f8b02751ca58b03dd8f7a256e04b0f75a83b154b74b0d829605c21fd8c71b68fc3550bfadb9a1b3c1485d691763da4bc71bf857aa81c"} 08:43:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:43:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:43:06 INFO - Contents: 08:43:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/294822e694c665bccb39e175c20d9d8ec0a1142cd3bff755f0187f76302c9f0ef25790304f0dcab171cb3d0d0257f644f89b82eb7c3d048d5b128fbca9d88ae7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8f39b99e91b477fe8da3d22e2ddffc7b213b2fedb32f9a5b05b30fb4ef495eb1521bc9a97c573ab4d4bb98aea167ddf6494f5d8210615a73a220535f385d8f71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/04d388e5559c0f2147d9f8b02751ca58b03dd8f7a256e04b0f75a83b154b74b0d829605c21fd8c71b68fc3550bfadb9a1b3c1485d691763da4bc71bf857aa81c"} 08:43:06 INFO - Running post-run listener: copy_logs_to_upload_dir 08:43:06 INFO - Copying logs to upload dir... 08:43:06 INFO - mkdir: /builds/slave/test/build/upload/logs 08:43:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.677092 ========= master_lag: 1.22 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-07-20 08:43:07.993549) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 08:43:07.996747) ========= 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=5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/294822e694c665bccb39e175c20d9d8ec0a1142cd3bff755f0187f76302c9f0ef25790304f0dcab171cb3d0d0257f644f89b82eb7c3d048d5b128fbca9d88ae7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8f39b99e91b477fe8da3d22e2ddffc7b213b2fedb32f9a5b05b30fb4ef495eb1521bc9a97c573ab4d4bb98aea167ddf6494f5d8210615a73a220535f385d8f71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/04d388e5559c0f2147d9f8b02751ca58b03dd8f7a256e04b0f75a83b154b74b0d829605c21fd8c71b68fc3550bfadb9a1b3c1485d691763da4bc71bf857aa81c"} build_url:https://queue.taskcluster.net/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/LiC6MwutRPGHkUuHYtCYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/294822e694c665bccb39e175c20d9d8ec0a1142cd3bff755f0187f76302c9f0ef25790304f0dcab171cb3d0d0257f644f89b82eb7c3d048d5b128fbca9d88ae7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8f39b99e91b477fe8da3d22e2ddffc7b213b2fedb32f9a5b05b30fb4ef495eb1521bc9a97c573ab4d4bb98aea167ddf6494f5d8210615a73a220535f385d8f71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/04d388e5559c0f2147d9f8b02751ca58b03dd8f7a256e04b0f75a83b154b74b0d829605c21fd8c71b68fc3550bfadb9a1b3c1485d691763da4bc71bf857aa81c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 08:43:08.026279) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 08:43:08.026709) ========= 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=5bd038846534b2fdfa68eeae000001e2-1469028125.602596-733374480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.28 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 08:43:08.309038) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 08:43:08.312579) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 08:43:08.313001) ========= ========= Total master_lag: 1.57 =========