builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1470661177.6 results: success (0) buildid: 20160808023008 builduid: 42f102f16a6c4fb7ae212d49f58fed10 revision: 46dede080ba1b6bcaaf5af7b00fc5e356c66faac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:59:37.602133) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:59:37.602858) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:59:37.603232) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:59:37.620383) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:59:37.621111) ========= 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=8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-08 05:59:37-- 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% 47.0M=0s 2016-08-08 05:59:37 (47.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081418 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:59:37.720631) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:59:37.721014) ========= 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=8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017283 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:59:37.772514) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 05:59:37.772975) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 46dede080ba1b6bcaaf5af7b00fc5e356c66faac --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 46dede080ba1b6bcaaf5af7b00fc5e356c66faac --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=8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-08 05:59:37,991 truncating revision to first 12 chars 2016-08-08 05:59:37,991 Setting DEBUG logging. 2016-08-08 05:59:37,991 attempt 1/10 2016-08-08 05:59:37,991 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/46dede080ba1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 05:59:38,899 unpacking tar archive at: fx-team-46dede080ba1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.348362 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 05:59:39.136574) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:59:39.137037) ========= script_repo_revision: 46dede080ba1b6bcaaf5af7b00fc5e356c66faac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:59:39.137574) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:59:39.137890) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:59:39.148629) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-08-08 05:59:39.149083) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:59:39 INFO - MultiFileLogger online at 20160808 05:59:39 in /builds/slave/test 05:59:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:59:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:59:39 INFO - {'append_to_log': False, 05:59:39 INFO - 'base_work_dir': '/builds/slave/test', 05:59:39 INFO - 'blob_upload_branch': 'Fx-Team', 05:59:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:59:39 INFO - 'branch': 'Fx-Team', 05:59:39 INFO - 'buildbot_json_path': 'buildprops.json', 05:59:39 INFO - 'config_files': ('talos/linux_config.py',), 05:59:39 INFO - 'default_actions': ('clobber', 05:59:39 INFO - 'read-buildbot-config', 05:59:39 INFO - 'download-and-extract', 05:59:39 INFO - 'populate-webroot', 05:59:39 INFO - 'create-virtualenv', 05:59:39 INFO - 'install', 05:59:39 INFO - 'run-tests'), 05:59:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:59:39 INFO - 'download_minidump_stackwalk': True, 05:59:39 INFO - 'download_symbols': 'ondemand', 05:59:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:59:39 INFO - 'tooltool.py': '/tools/tooltool.py', 05:59:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:59:39 INFO - '/tools/misc-python/virtualenv.py')}, 05:59:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:59:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:59:39 INFO - 'installer_path': 'installer.exe', 05:59:39 INFO - 'log_level': 'info', 05:59:39 INFO - 'log_name': 'talos', 05:59:39 INFO - 'log_to_console': True, 05:59:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:59:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:59:39 INFO - 'opt_config_files': (), 05:59:39 INFO - 'pip_index': False, 05:59:39 INFO - 'sps_profile': False, 05:59:39 INFO - 'sps_profile_interval': 0, 05:59:39 INFO - 'suite': 'dromaeojs-e10s', 05:59:39 INFO - 'system_bits': '32', 05:59:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:59:39 INFO - 'title': 'talos-linux64-ix-038', 05:59:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:59:39 INFO - 'use_talos_json': True, 05:59:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:59:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:59:39 INFO - 'work_dir': 'build'} 05:59:39 INFO - [mozharness: 2016-08-08 12:59:39.457752Z] Running clobber step. 05:59:39 INFO - Running pre-action listener: _resource_record_pre_action 05:59:39 INFO - Running main action method: clobber 05:59:39 INFO - rmtree: /builds/slave/test/build 05:59:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:59:39 INFO - Running post-action listener: _resource_record_post_action 05:59:39 INFO - [mozharness: 2016-08-08 12:59:39.918586Z] Finished clobber step (success) 05:59:39 INFO - [mozharness: 2016-08-08 12:59:39.918687Z] Running read-buildbot-config step. 05:59:39 INFO - Running pre-action listener: _resource_record_pre_action 05:59:39 INFO - Running main action method: read_buildbot_config 05:59:39 INFO - Using buildbot properties: 05:59:39 INFO - { 05:59:39 INFO - "project": "", 05:59:39 INFO - "product": "firefox", 05:59:39 INFO - "script_repo_revision": "production", 05:59:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:59:39 INFO - "repository": "", 05:59:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:59:39 INFO - "buildid": "20160808023008", 05:59:39 INFO - "pgo_build": "True", 05:59:39 INFO - "basedir": "/builds/slave/test", 05:59:39 INFO - "buildnumber": 653, 05:59:39 INFO - "slavename": "talos-linux64-ix-038", 05:59:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:59:39 INFO - "platform": "ubuntu64_hw", 05:59:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:59:39 INFO - "branch": "fx-team", 05:59:39 INFO - "repo_path": "integration/fx-team", 05:59:39 INFO - "revision": "46dede080ba1b6bcaaf5af7b00fc5e356c66faac", 05:59:39 INFO - "stage_platform": "linux64-pgo", 05:59:39 INFO - "builduid": "42f102f16a6c4fb7ae212d49f58fed10", 05:59:39 INFO - "slavebuilddir": "test" 05:59:39 INFO - } 05:59:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:59:39 INFO - Running post-action listener: _resource_record_post_action 05:59:39 INFO - [mozharness: 2016-08-08 12:59:39.921138Z] Finished read-buildbot-config step (success) 05:59:39 INFO - [mozharness: 2016-08-08 12:59:39.921227Z] Running download-and-extract step. 05:59:39 INFO - Running pre-action listener: _resource_record_pre_action 05:59:39 INFO - Running main action method: download_and_extract 05:59:39 INFO - mkdir: /builds/slave/test/build/tests 05:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:39 INFO - trying https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:59:39 INFO - Downloading https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:59:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:59:40 INFO - Downloaded 1361 bytes. 05:59:40 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:59:40 INFO - Using the following test package requirements: 05:59:40 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:59:40 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:40 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:59:40 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:40 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:59:40 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:40 INFO - u'jsshell-linux-x86_64.zip'], 05:59:40 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:40 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:59:40 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:59:40 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:40 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:59:40 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:40 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:59:40 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:40 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:59:40 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:40 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:59:40 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:40 INFO - trying https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:59:40 INFO - Downloading https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:59:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:59:41 INFO - Downloaded 21828583 bytes. 05:59:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:59:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:59:42 INFO - Return code: 0 05:59:42 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:42 INFO - trying https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:59:42 INFO - Downloading https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:59:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:59:43 INFO - Downloaded 21828583 bytes. 05:59:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:59:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:59:45 INFO - Return code: 0 05:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:45 INFO - trying https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:59:45 INFO - Downloading https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:59:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:59:45 INFO - Downloaded 14413723 bytes. 05:59:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:59:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:59:46 INFO - Return code: 0 05:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:46 INFO - trying https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:59:46 INFO - Downloading https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:59:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:59:47 INFO - Downloaded 59960069 bytes. 05:59:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:59:47 INFO - mkdir: /builds/slave/test/properties 05:59:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:59:47 INFO - Writing to file /builds/slave/test/properties/build_url 05:59:47 INFO - Contents: 05:59:47 INFO - build_url:https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:59:48 INFO - Running post-action listener: _resource_record_post_action 05:59:48 INFO - Running post-action listener: set_extra_try_arguments 05:59:48 INFO - [mozharness: 2016-08-08 12:59:48.074736Z] Finished download-and-extract step (success) 05:59:48 INFO - [mozharness: 2016-08-08 12:59:48.074969Z] Running populate-webroot step. 05:59:48 INFO - Running pre-action listener: _resource_record_pre_action 05:59:48 INFO - Running main action method: populate_webroot 05:59:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:59:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:59:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:59:48 INFO - '--tppagecycles', 05:59:48 INFO - '7'], 05:59:48 INFO - 'tests': ['tsvgm']}}, 05:59:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:59:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:59:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:59:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:59:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:59:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:59:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:48 INFO - 'talos_options': ['--disable-e10s'], 05:59:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:48 INFO - 'talos_options': ['--disable-e10s'], 05:59:48 INFO - 'tests': ['damp', 'tps']}, 05:59:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:48 INFO - 'tests': ['damp', 'tps']}, 05:59:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:59:48 INFO - 'tests': ['dromaeo_dom']}, 05:59:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:59:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:59:48 INFO - 'tests': ['basic_compositor_video']}, 05:59:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:59:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:59:48 INFO - 'tests': ['a11yr', 05:59:48 INFO - 'ts_paint', 05:59:48 INFO - 'tpaint', 05:59:48 INFO - 'sessionrestore', 05:59:48 INFO - 'sessionrestore_no_auto_restore', 05:59:48 INFO - 'tabpaint']}, 05:59:48 INFO - 'other-e10s': {'tests': ['a11yr', 05:59:48 INFO - 'ts_paint', 05:59:48 INFO - 'tpaint', 05:59:48 INFO - 'sessionrestore', 05:59:48 INFO - 'sessionrestore_no_auto_restore', 05:59:48 INFO - 'tabpaint']}, 05:59:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:59:48 INFO - 'ts_paint', 05:59:48 INFO - 'tpaint', 05:59:48 INFO - 'sessionrestore', 05:59:48 INFO - 'sessionrestore_no_auto_restore', 05:59:48 INFO - 'tabpaint']}, 05:59:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:59:48 INFO - 'ts_paint', 05:59:48 INFO - 'tpaint', 05:59:48 INFO - 'sessionrestore', 05:59:48 INFO - 'sessionrestore_no_auto_restore', 05:59:48 INFO - 'tabpaint']}, 05:59:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:59:48 INFO - 'tests': ['a11yr', 05:59:48 INFO - 'ts_paint', 05:59:48 INFO - 'tpaint', 05:59:48 INFO - 'sessionrestore', 05:59:48 INFO - 'sessionrestore_no_auto_restore', 05:59:48 INFO - 'tabpaint']}, 05:59:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:59:48 INFO - 'tests': ['a11yr', 05:59:48 INFO - 'ts_paint', 05:59:48 INFO - 'tpaint', 05:59:48 INFO - 'sessionrestore', 05:59:48 INFO - 'sessionrestore_no_auto_restore', 05:59:48 INFO - 'tabpaint']}, 05:59:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:59:48 INFO - 'tests': ['tsvgx', 05:59:48 INFO - 'tsvgr_opacity', 05:59:48 INFO - 'tart', 05:59:48 INFO - 'tscrollx', 05:59:48 INFO - 'cart']}, 05:59:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:59:48 INFO - 'tsvgr_opacity', 05:59:48 INFO - 'tart', 05:59:48 INFO - 'tscrollx', 05:59:48 INFO - 'cart']}, 05:59:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:48 INFO - 'talos_options': ['--disable-e10s'], 05:59:48 INFO - 'tests': ['tp5o']}, 05:59:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:48 INFO - 'tests': ['tp5o']}, 05:59:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:48 INFO - 'talos_options': ['--disable-e10s', 05:59:48 INFO - '--xperf_path', 05:59:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:48 INFO - 'tests': ['tp5n']}, 05:59:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:48 INFO - 'talos_options': ['--xperf_path', 05:59:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:48 INFO - 'tests': ['tp5n']}}, 05:59:48 INFO - 'talos.zip': {'path': '', 05:59:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:59:48 INFO - Running post-action listener: _resource_record_post_action 05:59:48 INFO - [mozharness: 2016-08-08 12:59:48.094989Z] Finished populate-webroot step (success) 05:59:48 INFO - [mozharness: 2016-08-08 12:59:48.095079Z] Running create-virtualenv step. 05:59:48 INFO - Running pre-action listener: _resource_record_pre_action 05:59:48 INFO - Running main action method: create_virtualenv 05:59:48 INFO - Creating virtualenv /builds/slave/test/build/venv 05:59:48 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 05:59:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:59:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:59:48 INFO - Using real prefix '/usr' 05:59:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:59:48 INFO - Installing distribute.............................................................................................................................................................................................done. 05:59:50 INFO - Installing pip.................done. 05:59:50 INFO - Return code: 0 05:59:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:50 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 0x21de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249d3b0>, '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 0x249e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249e740>, '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': '8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212', '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 05:59:50 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 05:59:50 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 05:59:50 INFO - Using env: {'DISPLAY': ':0', 05:59:50 INFO - 'HOME': '/home/cltbld', 05:59:50 INFO - 'LANG': 'en_US.UTF-8', 05:59:50 INFO - 'LANGUAGE': 'en_US:en', 05:59:50 INFO - 'LOGNAME': 'cltbld', 05:59:50 INFO - 'MAIL': '/var/mail/cltbld', 05:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:50 INFO - 'MOZ_NO_REMOTE': '1', 05:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:50 INFO - 'NO_EM_RESTART': '1', 05:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:50 INFO - 'PWD': '/builds/slave/test', 05:59:50 INFO - 'SHELL': '/bin/bash', 05:59:50 INFO - 'SHLVL': '1', 05:59:50 INFO - 'TERM': 'linux', 05:59:50 INFO - 'TMOUT': '86400', 05:59:50 INFO - 'USER': 'cltbld', 05:59:50 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212', 05:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:50 INFO - '_': '/tools/buildbot/bin/python'} 05:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:50 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 05:59:50 INFO - Cleaning up... 05:59:51 INFO - Return code: 0 05:59:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x21de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249d3b0>, '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 0x249e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249e740>, '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': '8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212', '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 05:59:51 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 05:59:51 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 05:59:51 INFO - Using env: {'DISPLAY': ':0', 05:59:51 INFO - 'HOME': '/home/cltbld', 05:59:51 INFO - 'LANG': 'en_US.UTF-8', 05:59:51 INFO - 'LANGUAGE': 'en_US:en', 05:59:51 INFO - 'LOGNAME': 'cltbld', 05:59:51 INFO - 'MAIL': '/var/mail/cltbld', 05:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:51 INFO - 'MOZ_NO_REMOTE': '1', 05:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:51 INFO - 'NO_EM_RESTART': '1', 05:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:51 INFO - 'PWD': '/builds/slave/test', 05:59:51 INFO - 'SHELL': '/bin/bash', 05:59:51 INFO - 'SHLVL': '1', 05:59:51 INFO - 'TERM': 'linux', 05:59:51 INFO - 'TMOUT': '86400', 05:59:51 INFO - 'USER': 'cltbld', 05:59:51 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212', 05:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:51 INFO - '_': '/tools/buildbot/bin/python'} 05:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:51 INFO - Downloading/unpacking psutil>=3.1.1 05:59:51 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 05:59:51 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 05:59:51 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 05:59:51 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 05:59:51 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 05:59:51 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 05:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:59:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:53 INFO - Installing collected packages: psutil 05:59:53 INFO - Running setup.py install for psutil 05:59:53 INFO - building 'psutil._psutil_linux' extension 05:59:53 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 05:59:53 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 05:59:53 INFO - building 'psutil._psutil_posix' extension 05:59:53 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 05:59:53 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 05:59:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:53 INFO - Successfully installed psutil 05:59:53 INFO - Cleaning up... 05:59:53 INFO - Return code: 0 05:59:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x21de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249d3b0>, '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 0x249e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249e740>, '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': '8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212', '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 05:59:53 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 05:59:53 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 05:59:53 INFO - Using env: {'DISPLAY': ':0', 05:59:53 INFO - 'HOME': '/home/cltbld', 05:59:53 INFO - 'LANG': 'en_US.UTF-8', 05:59:53 INFO - 'LANGUAGE': 'en_US:en', 05:59:53 INFO - 'LOGNAME': 'cltbld', 05:59:53 INFO - 'MAIL': '/var/mail/cltbld', 05:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:53 INFO - 'MOZ_NO_REMOTE': '1', 05:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:53 INFO - 'NO_EM_RESTART': '1', 05:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:53 INFO - 'PWD': '/builds/slave/test', 05:59:53 INFO - 'SHELL': '/bin/bash', 05:59:53 INFO - 'SHLVL': '1', 05:59:53 INFO - 'TERM': 'linux', 05:59:53 INFO - 'TMOUT': '86400', 05:59:53 INFO - 'USER': 'cltbld', 05:59:53 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212', 05:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:53 INFO - '_': '/tools/buildbot/bin/python'} 05:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:54 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 05:59:54 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 05:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:59:55 INFO - Installing collected packages: mozsystemmonitor 05:59:55 INFO - Running setup.py install for mozsystemmonitor 05:59:56 INFO - Successfully installed mozsystemmonitor 05:59:56 INFO - Cleaning up... 05:59:56 INFO - Return code: 0 05:59:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:56 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 0x21de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249d3b0>, '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 0x249e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249e740>, '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': '8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212', '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 05:59:56 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 05:59:56 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 05:59:56 INFO - Using env: {'DISPLAY': ':0', 05:59:56 INFO - 'HOME': '/home/cltbld', 05:59:56 INFO - 'LANG': 'en_US.UTF-8', 05:59:56 INFO - 'LANGUAGE': 'en_US:en', 05:59:56 INFO - 'LOGNAME': 'cltbld', 05:59:56 INFO - 'MAIL': '/var/mail/cltbld', 05:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:56 INFO - 'MOZ_NO_REMOTE': '1', 05:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:56 INFO - 'NO_EM_RESTART': '1', 05:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:56 INFO - 'PWD': '/builds/slave/test', 05:59:56 INFO - 'SHELL': '/bin/bash', 05:59:56 INFO - 'SHLVL': '1', 05:59:56 INFO - 'TERM': 'linux', 05:59:56 INFO - 'TMOUT': '86400', 05:59:56 INFO - 'USER': 'cltbld', 05:59:56 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212', 05:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:56 INFO - '_': '/tools/buildbot/bin/python'} 05:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:56 INFO - Downloading/unpacking jsonschema==2.5.1 05:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:56 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 05:59:56 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 05:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:59:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:59:58 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 05:59:58 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 05:59:58 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 05:59:58 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 05:59:58 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 05:59:58 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 05:59:58 INFO - Downloading functools32-3.2.3-2.tar.gz 05:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:59:58 INFO - warning: no files found matching '*.txt' 05:59:58 INFO - no previously-included directories found matching 'build' 05:59:58 INFO - no previously-included directories found matching 'dist' 05:59:58 INFO - no previously-included directories found matching '.git*' 05:59:58 INFO - Installing collected packages: jsonschema, functools32 05:59:58 INFO - Running setup.py install for functools32 05:59:58 INFO - warning: no files found matching '*.txt' 05:59:58 INFO - no previously-included directories found matching 'build' 05:59:58 INFO - no previously-included directories found matching 'dist' 05:59:58 INFO - no previously-included directories found matching '.git*' 05:59:58 INFO - Successfully installed jsonschema functools32 05:59:58 INFO - Cleaning up... 05:59:58 INFO - Return code: 0 05:59:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249d3b0>, '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 0x249e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249e740>, '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': '8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212', '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 05:59:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:59:58 INFO - Using env: {'DISPLAY': ':0', 05:59:58 INFO - 'HOME': '/home/cltbld', 05:59:58 INFO - 'LANG': 'en_US.UTF-8', 05:59:58 INFO - 'LANGUAGE': 'en_US:en', 05:59:58 INFO - 'LOGNAME': 'cltbld', 05:59:58 INFO - 'MAIL': '/var/mail/cltbld', 05:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:58 INFO - 'MOZ_NO_REMOTE': '1', 05:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:58 INFO - 'NO_EM_RESTART': '1', 05:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:58 INFO - 'PWD': '/builds/slave/test', 05:59:58 INFO - 'SHELL': '/bin/bash', 05:59:58 INFO - 'SHLVL': '1', 05:59:58 INFO - 'TERM': 'linux', 05:59:58 INFO - 'TMOUT': '86400', 05:59:58 INFO - 'USER': 'cltbld', 05:59:58 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212', 05:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:58 INFO - '_': '/tools/buildbot/bin/python'} 05:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:59:59 INFO - Cleaning up... 05:59:59 INFO - Return code: 0 05:59:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x21de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249d3b0>, '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 0x249e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249e740>, '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': '8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212', '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 05:59:59 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 05:59:59 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 05:59:59 INFO - Using env: {'DISPLAY': ':0', 05:59:59 INFO - 'HOME': '/home/cltbld', 05:59:59 INFO - 'LANG': 'en_US.UTF-8', 05:59:59 INFO - 'LANGUAGE': 'en_US:en', 05:59:59 INFO - 'LOGNAME': 'cltbld', 05:59:59 INFO - 'MAIL': '/var/mail/cltbld', 05:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:59 INFO - 'MOZ_NO_REMOTE': '1', 05:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:59 INFO - 'NO_EM_RESTART': '1', 05:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:59 INFO - 'PWD': '/builds/slave/test', 05:59:59 INFO - 'SHELL': '/bin/bash', 05:59:59 INFO - 'SHLVL': '1', 05:59:59 INFO - 'TERM': 'linux', 05:59:59 INFO - 'TMOUT': '86400', 05:59:59 INFO - 'USER': 'cltbld', 05:59:59 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212', 05:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:59 INFO - '_': '/tools/buildbot/bin/python'} 05:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:59 INFO - Downloading/unpacking blobuploader==1.2.4 05:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:59 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 05:59:59 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 05:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:01 INFO - Downloading blobuploader-1.2.4.tar.gz 06:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:00:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:01 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 06:00:01 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 06:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:00:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:01 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 06:00:01 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 06:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:01 INFO - Downloading docopt-0.6.1.tar.gz 06:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:00:01 INFO - Installing collected packages: blobuploader, requests, docopt 06:00:01 INFO - Running setup.py install for blobuploader 06:00:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:00:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:00:02 INFO - Running setup.py install for requests 06:00:02 INFO - Running setup.py install for docopt 06:00:02 INFO - Successfully installed blobuploader requests docopt 06:00:02 INFO - Cleaning up... 06:00:02 INFO - Return code: 0 06:00:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:02 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 0x21de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249d3b0>, '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 0x249e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249e740>, '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': '8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212', '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 06:00:02 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 06:00:02 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 06:00:02 INFO - Using env: {'DISPLAY': ':0', 06:00:02 INFO - 'HOME': '/home/cltbld', 06:00:02 INFO - 'LANG': 'en_US.UTF-8', 06:00:02 INFO - 'LANGUAGE': 'en_US:en', 06:00:02 INFO - 'LOGNAME': 'cltbld', 06:00:02 INFO - 'MAIL': '/var/mail/cltbld', 06:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:02 INFO - 'MOZ_NO_REMOTE': '1', 06:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:02 INFO - 'NO_EM_RESTART': '1', 06:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:02 INFO - 'PWD': '/builds/slave/test', 06:00:02 INFO - 'SHELL': '/bin/bash', 06:00:02 INFO - 'SHLVL': '1', 06:00:02 INFO - 'TERM': 'linux', 06:00:02 INFO - 'TMOUT': '86400', 06:00:02 INFO - 'USER': 'cltbld', 06:00:02 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212', 06:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:02 INFO - '_': '/tools/buildbot/bin/python'} 06:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:00:02 INFO - Running setup.py (path:/tmp/pip-wYuFZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:00:02 INFO - Running setup.py (path:/tmp/pip-GMYM48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:00:02 INFO - Running setup.py (path:/tmp/pip-9z_hbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:00:03 INFO - Running setup.py (path:/tmp/pip-Z6tAeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:00:03 INFO - Running setup.py (path:/tmp/pip-RN7lyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:00:03 INFO - Running setup.py (path:/tmp/pip-yekF32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:00:03 INFO - Running setup.py (path:/tmp/pip-h659Zr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:00:03 INFO - Running setup.py (path:/tmp/pip-yB3_mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:00:03 INFO - Running setup.py (path:/tmp/pip-04Odhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:00:03 INFO - Running setup.py (path:/tmp/pip-DvqDM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:00:03 INFO - Running setup.py (path:/tmp/pip-Hxgaxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:00:03 INFO - Running setup.py (path:/tmp/pip-anJbEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:00:03 INFO - Running setup.py (path:/tmp/pip-OsaDBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:00:03 INFO - Running setup.py (path:/tmp/pip-Fqt_vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:03 INFO - Running setup.py (path:/tmp/pip-x6Rnqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:00:03 INFO - Running setup.py (path:/tmp/pip-a2glx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:00:03 INFO - Running setup.py (path:/tmp/pip-5nown6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:00:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:00:04 INFO - Running setup.py install for manifestparser 06:00:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:00:04 INFO - Running setup.py install for mozcrash 06:00:04 INFO - Running setup.py install for mozdebug 06:00:04 INFO - Running setup.py install for mozdevice 06:00:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:00:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:00:04 INFO - Running setup.py install for mozfile 06:00:04 INFO - Running setup.py install for mozhttpd 06:00:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:00:04 INFO - Running setup.py install for mozinfo 06:00:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:00:04 INFO - Running setup.py install for mozInstall 06:00:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:00:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:00:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:00:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:00:04 INFO - Running setup.py install for mozleak 06:00:04 INFO - Running setup.py install for mozlog 06:00:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:00:05 INFO - Running setup.py install for moznetwork 06:00:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:00:05 INFO - Running setup.py install for mozprocess 06:00:05 INFO - Running setup.py install for mozprofile 06:00:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:00:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:00:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:00:05 INFO - Running setup.py install for mozrunner 06:00:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:00:05 INFO - Running setup.py install for mozscreenshot 06:00:05 INFO - Running setup.py install for moztest 06:00:05 INFO - Running setup.py install for mozversion 06:00:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:00:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:00:05 INFO - Cleaning up... 06:00:05 INFO - Return code: 0 06:00:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:05 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 0x21de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249d3b0>, '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 0x249e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249e740>, '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': '8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212', '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 06:00:05 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 06:00:05 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 06:00:05 INFO - Using env: {'DISPLAY': ':0', 06:00:05 INFO - 'HOME': '/home/cltbld', 06:00:05 INFO - 'LANG': 'en_US.UTF-8', 06:00:05 INFO - 'LANGUAGE': 'en_US:en', 06:00:05 INFO - 'LOGNAME': 'cltbld', 06:00:05 INFO - 'MAIL': '/var/mail/cltbld', 06:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:05 INFO - 'MOZ_NO_REMOTE': '1', 06:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:05 INFO - 'NO_EM_RESTART': '1', 06:00:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:05 INFO - 'PWD': '/builds/slave/test', 06:00:05 INFO - 'SHELL': '/bin/bash', 06:00:05 INFO - 'SHLVL': '1', 06:00:05 INFO - 'TERM': 'linux', 06:00:05 INFO - 'TMOUT': '86400', 06:00:05 INFO - 'USER': 'cltbld', 06:00:05 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212', 06:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:05 INFO - '_': '/tools/buildbot/bin/python'} 06:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:00:06 INFO - Running setup.py (path:/tmp/pip-PxTMya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:00:06 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)) 06:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:00:06 INFO - Running setup.py (path:/tmp/pip-7k00X3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:00:06 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)) 06:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:00:06 INFO - Running setup.py (path:/tmp/pip-Vq8zoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:00:06 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)) 06:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:00:06 INFO - Running setup.py (path:/tmp/pip-grosDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:00:06 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)) 06:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:00:06 INFO - Running setup.py (path:/tmp/pip-uanHKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:00:06 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)) 06:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:00:06 INFO - Running setup.py (path:/tmp/pip-zxpCm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:00:06 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)) 06:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:00:06 INFO - Running setup.py (path:/tmp/pip-mcB97a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:00:06 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)) 06:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:00:06 INFO - Running setup.py (path:/tmp/pip-58GaUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:00:06 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)) 06:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:00:06 INFO - Running setup.py (path:/tmp/pip-kJYNxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:00:06 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)) 06:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:00:06 INFO - Running setup.py (path:/tmp/pip-DzI_2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:00:06 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)) 06:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:00:06 INFO - Running setup.py (path:/tmp/pip-cvuHMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:00:06 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)) 06:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:00:06 INFO - Running setup.py (path:/tmp/pip-cBfs0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:00:06 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)) 06:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:00:06 INFO - Running setup.py (path:/tmp/pip-j91NX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:00:07 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)) 06:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:00:07 INFO - Running setup.py (path:/tmp/pip-I30iCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:00:07 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)) 06:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:07 INFO - Running setup.py (path:/tmp/pip-Coga6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:07 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)) 06:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:00:07 INFO - Running setup.py (path:/tmp/pip-uZ9bM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:00:07 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)) 06:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:00:07 INFO - Running setup.py (path:/tmp/pip-nbz65q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:00:07 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)) 06:00:07 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)) 06:00:07 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)) 06:00:07 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)) 06:00:07 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)) 06:00:07 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)) 06:00:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:00:07 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 06:00:07 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 06:00:07 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 06:00:07 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 06:00:07 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 06:00:07 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 06:00:09 INFO - Downloading blessings-1.6.tar.gz 06:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:00:09 INFO - Installing collected packages: blessings 06:00:09 INFO - Running setup.py install for blessings 06:00:09 INFO - Successfully installed blessings 06:00:09 INFO - Cleaning up... 06:00:09 INFO - Return code: 0 06:00:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:00:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:00:09 INFO - Reading from file tmpfile_stdout 06:00:09 INFO - Current package versions: 06:00:09 INFO - argparse == 1.2.1 06:00:09 INFO - blessings == 1.6 06:00:09 INFO - blobuploader == 1.2.4 06:00:09 INFO - docopt == 0.6.1 06:00:09 INFO - functools32 == 3.2.3-2 06:00:09 INFO - jsonschema == 2.5.1 06:00:09 INFO - manifestparser == 1.1 06:00:09 INFO - mozInstall == 1.12 06:00:09 INFO - mozcrash == 0.17 06:00:09 INFO - mozdebug == 0.1 06:00:09 INFO - mozdevice == 0.48 06:00:09 INFO - mozfile == 1.2 06:00:09 INFO - mozhttpd == 0.7 06:00:09 INFO - mozinfo == 0.9 06:00:09 INFO - mozleak == 0.1 06:00:09 INFO - mozlog == 3.3 06:00:09 INFO - moznetwork == 0.27 06:00:09 INFO - mozprocess == 0.23 06:00:09 INFO - mozprofile == 0.28 06:00:09 INFO - mozrunner == 6.12 06:00:09 INFO - mozscreenshot == 0.1 06:00:09 INFO - mozsystemmonitor == 0.3 06:00:09 INFO - moztest == 0.7 06:00:09 INFO - mozversion == 1.4 06:00:09 INFO - psutil == 3.1.1 06:00:09 INFO - requests == 1.2.3 06:00:09 INFO - wsgiref == 0.1.2 06:00:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:09 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 0x21de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249d3b0>, '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 0x249e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249e740>, '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': '8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212', '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 06:00:09 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 06:00:09 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 06:00:09 INFO - Using env: {'DISPLAY': ':0', 06:00:09 INFO - 'HOME': '/home/cltbld', 06:00:09 INFO - 'LANG': 'en_US.UTF-8', 06:00:09 INFO - 'LANGUAGE': 'en_US:en', 06:00:09 INFO - 'LOGNAME': 'cltbld', 06:00:09 INFO - 'MAIL': '/var/mail/cltbld', 06:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:09 INFO - 'MOZ_NO_REMOTE': '1', 06:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:09 INFO - 'NO_EM_RESTART': '1', 06:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:09 INFO - 'PWD': '/builds/slave/test', 06:00:09 INFO - 'SHELL': '/bin/bash', 06:00:09 INFO - 'SHLVL': '1', 06:00:09 INFO - 'TERM': 'linux', 06:00:09 INFO - 'TMOUT': '86400', 06:00:09 INFO - 'USER': 'cltbld', 06:00:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212', 06:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:09 INFO - '_': '/tools/buildbot/bin/python'} 06:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:09 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)) 06:00:09 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)) 06:00:09 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)) 06:00:09 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)) 06:00:09 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)) 06:00:09 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)) 06:00:09 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)) 06:00:09 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)) 06:00:09 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)) 06:00:09 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)) 06:00:09 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)) 06:00:09 INFO - Cleaning up... 06:00:09 INFO - Return code: 0 06:00:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:09 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 0x21de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249d3b0>, '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 0x249e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249e740>, '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': '8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212', '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 06:00:09 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 06:00:09 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 06:00:09 INFO - Using env: {'DISPLAY': ':0', 06:00:09 INFO - 'HOME': '/home/cltbld', 06:00:09 INFO - 'LANG': 'en_US.UTF-8', 06:00:09 INFO - 'LANGUAGE': 'en_US:en', 06:00:09 INFO - 'LOGNAME': 'cltbld', 06:00:09 INFO - 'MAIL': '/var/mail/cltbld', 06:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:09 INFO - 'MOZ_NO_REMOTE': '1', 06:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:09 INFO - 'NO_EM_RESTART': '1', 06:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:09 INFO - 'PWD': '/builds/slave/test', 06:00:09 INFO - 'SHELL': '/bin/bash', 06:00:09 INFO - 'SHLVL': '1', 06:00:09 INFO - 'TERM': 'linux', 06:00:09 INFO - 'TMOUT': '86400', 06:00:09 INFO - 'USER': 'cltbld', 06:00:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212', 06:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:09 INFO - '_': '/tools/buildbot/bin/python'} 06:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:00:10 INFO - Cleaning up... 06:00:10 INFO - Return code: 0 06:00:10 INFO - Running post-action listener: _resource_record_post_action 06:00:10 INFO - Running post-action listener: _start_resource_monitoring 06:00:10 INFO - Starting resource monitoring. 06:00:10 INFO - [mozharness: 2016-08-08 13:00:10.086760Z] Finished create-virtualenv step (success) 06:00:10 INFO - [mozharness: 2016-08-08 13:00:10.087200Z] Running install step. 06:00:10 INFO - Running pre-action listener: _resource_record_pre_action 06:00:10 INFO - Running main action method: install 06:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:00:10 INFO - Reading from file tmpfile_stdout 06:00:10 INFO - Detecting whether we're running mozinstall >=1.0... 06:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:00:10 INFO - Reading from file tmpfile_stdout 06:00:10 INFO - Output received: 06:00:10 INFO - Usage: mozinstall [options] installer 06:00:10 INFO - Options: 06:00:10 INFO - -h, --help show this help message and exit 06:00:10 INFO - -d DEST, --destination=DEST 06:00:10 INFO - Directory to install application into. [default: 06:00:10 INFO - "/builds/slave/test"] 06:00:10 INFO - --app=APP Application being installed. [default: firefox] 06:00:10 INFO - mkdir: /builds/slave/test/build/application 06:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:00:27 INFO - Reading from file tmpfile_stdout 06:00:27 INFO - Output received: 06:00:27 INFO - /builds/slave/test/build/application/firefox/firefox 06:00:27 INFO - Running post-action listener: _resource_record_post_action 06:00:27 INFO - [mozharness: 2016-08-08 13:00:27.451706Z] Finished install step (success) 06:00:27 INFO - [mozharness: 2016-08-08 13:00:27.451953Z] Running run-tests step. 06:00:27 INFO - Running pre-action listener: _resource_record_pre_action 06:00:27 INFO - Running main action method: run_tests 06:00:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:00:27 INFO - Python 2.7.3 06:00:27 INFO - Return code: 0 06:00:27 INFO - grabbing minidump binary from tooltool 06:00: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:00:27 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 0x249d3b0>, '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 0x249e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:00:27 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 06:00:27 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 06:00:27 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 06:00:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:00:27 INFO - Return code: 0 06:00:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:00:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:00:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:00:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:00:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:00:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 06:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 06:00:27 INFO - Using env: {'DISPLAY': ':0', 06:00:27 INFO - 'HOME': '/home/cltbld', 06:00:27 INFO - 'LANG': 'en_US.UTF-8', 06:00:27 INFO - 'LANGUAGE': 'en_US:en', 06:00:27 INFO - 'LOGNAME': 'cltbld', 06:00:27 INFO - 'MAIL': '/var/mail/cltbld', 06:00:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:00:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:27 INFO - 'MOZ_NO_REMOTE': '1', 06:00:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:27 INFO - 'NO_EM_RESTART': '1', 06:00:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:27 INFO - 'PWD': '/builds/slave/test', 06:00:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:00:27 INFO - 'SHELL': '/bin/bash', 06:00:27 INFO - 'SHLVL': '1', 06:00:27 INFO - 'TERM': 'linux', 06:00:27 INFO - 'TMOUT': '86400', 06:00:27 INFO - 'USER': 'cltbld', 06:00:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212', 06:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:27 INFO - '_': '/tools/buildbot/bin/python'} 06:00:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 06:00:27 INFO - mozversion application_buildid: 20160808023008 06:00:27 INFO - mozversion application_changeset: 46dede080ba1b6bcaaf5af7b00fc5e356c66faac 06:00:27 INFO - mozversion application_display_name: Nightly 06:00:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:00:27 INFO - mozversion application_name: Firefox 06:00:27 INFO - mozversion application_remotingname: firefox 06:00:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:00:27 INFO - mozversion application_vendor: Mozilla 06:00:27 INFO - mozversion application_version: 51.0a1 06:00:27 INFO - mozversion platform_buildid: 20160808023008 06:00:27 INFO - mozversion platform_changeset: 46dede080ba1b6bcaaf5af7b00fc5e356c66faac 06:00:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:00:27 INFO - mozversion platform_version: 51.0a1 06:00:27 INFO - using testdate: 1470661227 06:00:27 INFO - actual date: 1470661227 06:00:27 INFO - starting webserver on 'localhost:41585' 06:00:27 INFO - SUITE-START | Running 2 tests 06:00:27 INFO - TEST-START | dromaeo_css 06:00:27 INFO - operating with platform_type : linux_ 06:00:27 INFO - Initialising browser for dromaeo_css test... 06:00:27 INFO - TEST-INFO | started process 22841 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZHdGtO/profile http://localhost:41585/getInfo.html) 06:00:32 INFO - PROCESS | 22841 | __metrics Screen width/height:1600/1200 06:00:32 INFO - PROCESS | 22841 | colorDepth:24 06:00:32 INFO - PROCESS | 22841 | Browser inner width/height: 1024/697 06:00:32 INFO - PROCESS | 22841 | __metrics 06:00:33 ERROR - PROCESS | 22841 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 06:00:34 INFO - TEST-INFO | 22841: exit 0 06:00:34 INFO - Browser initialized. 06:00:34 INFO - Running cycle 1/1 for dromaeo_css test... 06:00:34 INFO - TEST-INFO | started process 22961 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZHdGtO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:00:46 INFO - PROCESS | 22961 | RSS: Main: 164052992 06:00:46 INFO - PROCESS | 22961 | 06:01:36 INFO - PROCESS | 22961 | 1470661296064 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] 06:03:45 INFO - PROCESS | 22961 | Cycle 1(1): loaded http://localhost:41585/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41585/tests/dromaeo/cssquery-ext.html) 06:03:46 INFO - PROCESS | 22961 | RSS: Main: 167018496 06:03:46 INFO - PROCESS | 22961 | 06:06:48 INFO - PROCESS | 22961 | Cycle 1(1): loaded http://localhost:41585/tests/dromaeo/cssquery-ext.html (next: http://localhost:41585/tests/dromaeo/cssquery-jquery.html) 06:06:49 INFO - PROCESS | 22961 | RSS: Main: 166760448 06:06:49 INFO - PROCESS | 22961 | 06:09:51 INFO - PROCESS | 22961 | Cycle 1(1): loaded http://localhost:41585/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41585/tests/dromaeo/cssquery-mootools.html) 06:09:52 INFO - PROCESS | 22961 | RSS: Main: 169971712 06:09:52 INFO - PROCESS | 22961 | 06:12:53 INFO - PROCESS | 22961 | Cycle 1(1): loaded http://localhost:41585/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41585/tests/dromaeo/cssquery-prototype.html) 06:12:54 INFO - PROCESS | 22961 | RSS: Main: 164491264 06:12:54 INFO - PROCESS | 22961 | 06:15:57 INFO - PROCESS | 22961 | Cycle 1(1): loaded http://localhost:41585/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41585/tests/dromaeo/cssquery-yui.html) 06:15:57 INFO - PROCESS | 22961 | RSS: Main: 166801408 06:15:57 INFO - PROCESS | 22961 | 06:19:00 INFO - PROCESS | 22961 | Cycle 1(1): loaded http://localhost:41585/tests/dromaeo/cssquery-yui.html (next: http://localhost:41585/tests/dromaeo/cssquery-dojo.html) 06:19:00 INFO - PROCESS | 22961 | RSS: Main: 169656320 06:19:00 INFO - PROCESS | 22961 | 06:19:00 INFO - PROCESS | 22961 | __start_tp_report 06:19:00 INFO - PROCESS | 22961 | _x_x_mozilla_page_load 06:19:00 INFO - PROCESS | 22961 | _x_x_mozilla_page_load_details 06:19:00 INFO - PROCESS | 22961 | |i|pagename|runs| 06:19:00 INFO - PROCESS | 22961 | |0;dojo.html;3151.3382189740155;3165.9683403165964;3188.856501457434;3191.888283910064;3194.5687332210146;5467.507924286813;5498.340199176099;5554.888902221958;5561.666300022001;5583.553315734742;5395.190721391793;5490.6431081979745;5513.09034009388;5568.6658800472;5587.1339942308905;4705.294205869112;4870.147724148278;4976.104301225778;5030.295758593781;5128.05131050755;5073.441921388663;5083.898322033557;5084.110280700881;5090.643654944155;5147.48525147486;4886.9511304886855;4893.902121957576;4903.338049363361;5009.949900500985;5067.974660126676;4930.186519224324;4972.90054198914;4979.0788704089855;4984.551390374883;4996.375453068366;4889.902201955941;4952.232403977389;4955.4548999610015;4958.925616115761;4989.57588604969;5377.300950876361;5419.403865574784;5439.782408703647;5445.482679145475;5448.318960129984;5839.824805255849;5853.882922341572;5856.76572937082;5862.325832529271;5886.234789477383;5872.559558033122;5873.383294754075;5879.176915231871;5888.793892213752;5891.911621325684;5401.621886467949;5451.672899626035;5454.3454785426;5465.59008074396;5495.120780675073;5988.161657367972;5998.730057147439;6007.339192688801;6011.639301641828;6040.637561746309;5703.258576385043;5734.827955161351;5748.166515855261;5762.971185144132;5772.509336706427;5737;5820.447057529528;5860;5863.853403664943;5867.765289388377;5851.590388672837;5857.15071314657;5879.911801322984;5885.028970219866;5916.437938395846;5843.590948633555;5860.560457965669;5881.882362352729;5889.469947704727;5901.380355062743;4392.3191905254735;4466.1514312281215;4472.865814025585;4514.187446259639;4515.932261016087;4003.2393845169327;4004.739691920074;4009.3384591542067;4045.292073887058;4067.5322337930925;5594.244776955059;5611.466910643482;5619.662820230799;5646.858828529237;5649.632773869767;5749.8275051748515;5859.121131830259;5895.145203945404;5922.230110085661;5946.881062378815;5622.718864056781;5622.746976386073;5623.212750214973;5633.605647604629;5634.690092044977;5081.4918508148885;5083;5084.288199652052;5087.313212716236;5142.331496905378;5965.492933100648;6030.065339872239;6048.455638992512;6084.513238940785;6181;5832.329282132439;5850.385709500441;5851.795187168429;5882.617629854046;5884.411558844081;6002.249718785152;6042.607230530001;6043.879122417439;6045.183900173421;6046.516278697605;5695.316562012585;5724.427557244242;5729.54163666914;5734.7132643368495;5761.452661997104;5878.2358293421585;5884.617499862667;5884.970130227279;5901.173835663097;5930.555208359304;5703.657780533182;5745.569082318759;5754.424557544379;5756.30924289088;5763.36602973681;5571.60998730085;5650.745716442688;5710.714464276686;5719.656820590778;5725.770969161187;5742.913856292075;5767.509761670305;5767.68277744728;5801.071828507418;5819.388964158702;5757.568182386254;5777.595568310178;5780.682062486436;5815.273090863642;5817.418258174149;5573.554115670818;5640.774369025357;5654.6889921054735;5657.660540367591;5667.291588551431 06:19:00 INFO - PROCESS | 22961 | |1;ext.html;550.5105861697853;586.4282324733383;600.6036016229289;612.1154931124526;649.7336092202198;38952.805235973814;43407.56592434075;43623.34564981528;43867.78066109673;43949;43102.353464698055;43141.784291078504;43401.78299108508;43606.34590481145;43646.12707745843;8844.601992910302;8972.057933916944;8989.101089891024;8991.10088991099;8993.550322483883;8944.955275223647;8949.507777072258;9020.774480638003;9023.593938272794;9029.548522573878;9079.500627465486;9087.681931132413;9133.17801397874;9140.54297285133;9143.08569143087;9004.864927026067;9051.547422628875;9066.546672666373;9067.274618030542;9078.77303067422;8922.241609463203;8949.910500894974;8965.641374345018;8994.10058994102;8996.415233009833;42143.36784948228;42279.7886010571;42490;42598;42603.36094958578;3426;3525.5593050868642;3568.57177138745;3668.9633103669157;3990.221906728189;33093.4536707553;33614.83192584046;33811.6618833811;33907.830460847785;34722.30555388878;4250.872473825791;4367.541408152162;4401.9119617607785;4405.911881762347;4423.380726698265;351119;351660;352346;352746;353054.99999999744;59466.40533594609;59706.70146649326;60117.39882601118;60128.39871601316;60213;62734;62869.74260514764;62908;63094.369056308846;63109.68445157745;16670.16649167537;17378.39175628847;17388.91305543464;17886;17905.19426625805;13243.139195952232;13259.933700331436;13299.401526931311;13309.600711978655;13332.400041998133;19564.652241730797;19770.30803921856;19787.30744423938;19937.302194423417;20030.298939537046;6936.4797640177185;7000.474964377692;7103.92896071043;7140.285971402922;7561.508501947355;982.8967958364269;1060.4273692206277;1113.821788513834;1114.5541783286587;1148.661144962238;33031.33937321288;33184;33195.40183986298;33325.33349333;33536;1092.9016388525072;1132.5809450503366;1147.5467190459722;1152.6196355202762;1198.394810620631;17103.23035463407;17190.484285471455;17273.136343182792;17413.216405261795;17468.388606398716;618926;621576;621867;625101;625316;40327.59672403297;40429.595704043175;40621.593784062374;40746.79626601848;60999;1317.4466723975954;1367.3505085084505;1371.1087792934673;1384.9861501385058;1385.958421247344;30720.623890819465;32672;32695.50956735603;33048.834755826065;33188.51954986046;54778.72610637081;56298.90356030458;56404.717976409855;63630.36369636429;63631;494231;495896;497129;497146;499667;44842.96413322817;45141.0971780556;45267.320990185835;45763.54236457593;46028;49359.25961110658;50111.74944125256;50299.74850125872;50465.74767126141;51585;41810.790946045076;42569.5743042578;43247.56752432435;43596.78201608972;44626.55373446224;42425.15149696927;42449.36325955051;43173.78413107914;43640.345394819735;43923;42303.576964229964;42474.81155310024;43765;43863;43950.12099758051;34689.43897524668;37061.2073574755;37367;38037.61962380341;38397.808010959765;28579;28791.280217994718;28970.53750431237;29054.564181536873;29367.853160734914 06:19:00 INFO - PROCESS | 22961 | |2;jquery.html;385.4218671992012;390.2059309305562;404.437831414334;410.73712823792766;415.56158253043026;18612.53468663284;19547.41357759266;20089.196432142697;20510.38468845935;20522.38432847015;19236.71144932827;19463.90268048661;19881.204751809946;20258.189672413086;20300.18799248028;5446.101393270125;5639.407862174474;5666.405027472118;5672.801451949193;5677.687727175004;5700.258966334371;5705.115707065412;5708.628939118965;5719.77120915165;5723.54211663066;5809.419058094199;5897.616654917417;5921.289445266574;5928.614640048405;5931.911021334683;5422.566194704415;5635.520980716644;5705.885882282372;5766.423357664242;5876.265466816648;5518.2826232589905;5556;5562.888742225133;5570.387257401682;5582.525485333752;13776.65558361049;13920;14165.929170354082;23164.073437062496;23369.182078627335;2207.9889600552056;2273.4089136824546;2343.953120937572;2378.5242951409787;2477.2444404456633;10044.89955100447;10131.79736405275;10142.18862490999;10174.084332410119;10194.9490252549;1830.4234166237593;1871.4479228627588;1910.6942889137672;1956.980430195694;1969.7636283646054;83094;86978.13021869764;87489.56255218684;87600;89471;10247.38515689061;10429.68710938673;10832.891671083345;10863.67408977732;11107.500162492708;13866.376013079436;13929.373178207004;13973.09174903628;14013.43946242139;14015.649608759659;7762.883556746653;7962.163972782891;8026;8195.754127376189;8254.298384637374;7825.843483130306;7918.524888506708;8003.19968003195;8098.190180981855;8109.189081091961;4202.810873510699;4387.451568553931;4598.241290187082;4739.715617062987;4743.241081427024;1923.5768131011155;1991.541945352577;2075.73015507983;2093.8324934005245;2127.3086246969797;913.963441462334;928.5728564860104;946.6355453150449;960.9231261499203;1022.882368527614;19217.80782192188;20573.69139462909;20803.68794468084;20845.58308833815;21049.579008419747;969.9757506062264;996.9152622027063;1016.7407311135613;1027.291169093323;1079.6707004363745;10121.493925303705;11580.131490138105;11615;11626.186166968231;11645.767084658259;499513;520146;522576;537391;537516;88686;89817.55091224502;98729;98747;98970.5051474738;987.3878195518824;1015.6242190389455;1049.275999560301;1050.4275170032352;1059.9682009539727;18030.819691802913;18370.540736481697;18616.936289195233;18833;18846.43460696181;44033;44834.77582612066;44950.77524612356;45709.77145114386;46111;63348;64784.67607661932;65561.67219164064;66049.66975165093;66232.6688366555;8694.565271736514;8828.38201325901;8828.38201325901;8923.107689231025;9212.216961558343;12853.485860565472;13674.247916364695;13822.861771382157;13873.930630346784;14244.786328205293;11670.241434307083;11833;11917.761644766882;12222.144449888423;12559.560415385418;12005.313942105831;12076.818847717115;12126.869396801267;12176.817347739969;12566.874331256937;11708.765824683629;11709.824352634887;12107.81838272409;12185.147039707135;12333.62999110028;8586.527740974307;8612.138786121588;8846.955765221133;8883;8926.68756593516;10173.745656358355;11136.721581960515;11223.214374993671;12383.071269654993;12420.254784712946 06:19:00 INFO - PROCESS | 22961 | |3;mootools.html;1491.8358980512141;1522.4747462125567;1635.092523649374;1765.8057613662486;1776.2539733312008;8043.477173983687;8572.22849943505;8737.956310218457;9274.81450370993;9296.8605470918;8783.165599268075;9120.589573469193;9144.817103657922;9188.540572971342;9222;2435.975640243597;2465.9136930207446;2485.403503159247;2486.3286912533604;2487.8382905111202;2384.1893756122913;2472.6909136357954;2484.8260621756394;2487.676602041732;2490.3774056485877;2435.6468312094735;2436.8050555955483;2478.033566908907;2501.1496091328945;2502.3744063984004;2428.0287884846116;2442.218490083174;2443.450223699671;2446.3150317911013;2453.6074228123503;2414.9275521734376;2422.4307287787356;2430.307362401707;2435.866027368494;2441.8645329921674;9067.319951003701;9086.727398178065;9124.680636177769;9154.86267705985;9155.862662060075;5453.100238460649;5568.638038527482;5591.3569939456665;5604.1593760935775;5606.383297837235;3403.128329201381;3487.7907325560545;3500.929981400383;3545.042838433634;3583.802890841003;1084.203110713625;1127.5546159267126;1134.126722423729;1136.693092864922;1150.5340337163461;12839.74320513594;12868.420921058574;12900.419481123372;12978.480860765558;12994.15537990037;4736.478987311393;4839.443464001614;4886.780094895738;4888.7311197884455;5022.7990880365105;10765.084967777826;10765.892341076646;10766.246362754531;10829.133669306437;10832.241743078066;5539.446055394428;5580.2466666999435;5604.215409842625;5608.1027035674915;5611.298587676541;4460.085682435158;4914.90170196594;5027.371578552681;5052.8484145475695;5141.100307446182;4082.4415378517915;4100.856470023535;4182.937255941163;4226.873193804129;4230.894227644333;1308.4112149532557;1338.3910320804205;1350.2843492948753;1352.4454973460834;1367.856375080622;821.3675469888273;920.7007722490217;936.4334577580465;952.1953948913157;966.8694726212012;5909.527237820964;5980.66133460663;5988.311344195473;6000.519958403317;6084.30030546484;431.2345586583839;464.7443905851768;480.5962991087503;484.7527760841996;485.06382681425185;3966.960330396717;4077.2457095436844;4136.503619565611;4138.8551400700835;4140.068484590943;11037.172212084126;11354.48904799286;11395.14536409756;11427.314361138358;11431.714207144722;11123.998840104268;11200.271982321123;11249.606263780892;11350.3757293348;11380.658580242605;8219.630116644765;8348.874766878502;8379.37154713399;8389.412741108186;8400.3199360127;5650.434956504317;5832.737526811219;5857.648541087548;5871.706414679335;5942.376050514807;10224.130948869131;10276.407156890695;10321.48392580383;10370.948145259226;10371.222158338003;10578.471076445992;10593.205509586965;10597.62908298206;10654.520546575268;10705.250632455965;7058.400035996792;7440.776776696708;7469.813254668459;8055.476394034369;8146.959265203636;8533.573321334032;8567.057623661516;8602.655893764178;8610.354223433393;8625.827483450421;7109.502334836512;7376.557406555409;7381.8154546136775;7399.630018498946;7490.176080631018;7437.962810185914;7556.697732090654;7581.355584775135;7668.309852113337;7946.642401091849;6980.162380514168;7100.183478899786;7110.857782844418;7111.644417779194;7139.678714457758;5307.628466007497;5311;5360;5389.946100538945;5573.7770489179975;5243.265942767939;5291.708956007456;5346.759395827275;5378.354597448331;5577.804776832953 06:19:00 INFO - PROCESS | 22961 | |4;prototype.html;331.9502074688798;333.53305372478525;340.8977306807957;342.62653707458867;345.40072973391176;5437.619366644337;5445.428230035848;5609.663420194791;5687.544996400288;5731.168980497825;5459.188517913278;5523.7238138093135;5538.667679939196;5541.503793975634;5569.972150139243;4357.586029327217;4367.825286988516;4373.606375426211;4400.251957167273;4424.845130420436;4079.2453396121814;4318.9784051079705;4350.412694286279;4397.956020439787;4410.536893626171;4280.978595107035;4282.528921818597;4286.314189729644;4288.69979101463;4296.162248361571;4245.87262382129;4277.786110694484;4285.314349704033;4307.418498502709;4324.762138082404;3580.445031020196;3777.452269420946;3786.3752480840626;3799.886003419902;3804.1630841214887;5356.517913387814;5401.864953376158;5429.809956651498;5456.045192091407;5468.207109969032;4919.655624106314;4926.975365123151;4926.975365123188;4927.704337739711;4942.728149951751;5520.861978450571;5811.476967072941;5835.503982161521;5848.90008295604;5852.853678658025;4142.668586513102;4149.107941792499;4150.232207041677;4161.791910404468;4164.146349998243;6044.304904935901;6083.452489275942;6119.785807496716;6134.846628834271;6152.230971128564;4155.646770024521;4182.498100227992;4222.577742225814;4255.765932873722;4259.2759230930815;4260;4277.615014648634;4294.162638285567;4299.871003869889;4300.505441874225;4921.892574170783;4925.975370123127;4928.507149285043;4931.802727890916;4973.1297023020825;5737.282839645044;5851;5876.588638795243;5901.7639294427745;5927.614705044159;1476.320892389513;1491.61963699256;1492.2986196487634;1493.873020793223;1498.5204734485078;887.3611000079932;932.7668082979255;939.8261321655516;950.1068995144542;952.2667545989549;4886.486918873538;4928.704277743275;4929.531694489017;4930.580900623416;4996.550310472075;5203.479652034842;5212.921806172911;5250.65870718402;5255.474452554714;5267.578593712494;4621.32990716351;4894.681845680019;4961.50384961501;4979.950200498021;4998.875477921869;2792.4415116976684;2806.5088609493255;2811.718828117172;2822.8990693629503;2827.7313655202724;5474.549244450224;5490.945090549123;5494.170502191375;5503.697296648643;5536;5165.276861239429;5363.302770639792;5386.407495175527;5391.4608539145775;5427.15476737911;5403.486668766461;5421.512063914267;5432.891342173134;5447.836564903059;5461.433126430492;5014.620979230741;5175.275461435327;5190.455002224712;5251.422343542131;5269.841904742864;5079.6952182869145;5126.333576635014;5173.32746742921;5174.586033117417;5186.974065129651;5395.973020134874;5399.4600539945695;5420.457954204548;5441.619086663895;5443.755031023693;3981.7212795104065;4169.457970463942;4238.660907127484;4308.978455107705;4316.136772645421;5964.061679953946;5976.462118409364;5989.580729348903;5997.820065398045;6000.669963152069;5666.405027472056;5829.883402332014;5840;5843.539115221195;5894.498967587803;5707.800226992035;5752.073055526445;5752.424757524214;5786.33457152416;5808.796692115756;5761.5390768739235;5819.388964158702;5823.912641310299;5826.446487583673;5832.737526811219;5668.546516278605;5815.82552523425;5824.475797178275;5866.472017518444;5885.646861188342;5681.886362272814;5713.9142912855505;5720.628159169641;5752.453516915886;5759.856003599776 06:19:00 INFO - PROCESS | 22961 | |5;yui.html;784.6390660296263;793.1711361627099;803.5901690138028;823.1973825520117;843.9451435656678;14837;15628.2967266473;15643.530694079196;15667.451639192645;15791.052536847797;14080.084794488352;14149;14189;14194.503192388269;14195;662.4170729757807;782.4679218131654;797.752696664036;811.853866304065;826.1614461321764;812.7846120777998;823.1028179284579;823.3948048184579;823.4112609484217;827.2182787266036;879.7404765594165;879.7976465412959;882.2280504558511;882.4087861133056;883.0154377868695;872.1060912564609;876.601146478354;880.3749337970049;880.5113162194979;880.6565439478609;634.346622978333;638.3201889987149;638.865838173984;639;640.4908098062052;15374.538763837103;15482.45811396607;15493.225338733018;15513.767293490606;15520.61198470036;12978.870211297955;13438.664033399145;13719;13884.58346249604;16153.596160095974;13816.516421925184;13861.584152475441;13986.93006534971;14029.508967186202;14123.293835308194;4523.117991991563;4532.297493888453;4573.062522182944;4767.523247675239;4786.16242157621;93308;94109.05890941071;94123;95881.5205923966;95889;11621.6513504595;11642.281899139247;11658.242214256215;11701.063914886789;11826.349550774617;21693.56612867734;21819;21822.890885545472;21900;22161.445963851034;8254.133316001853;8317.708880189286;8327.916720832714;8401.915980840236;8457.661693532313;4637.489876113625;4657.46439159501;4732.597729193058;4783.976080119577;4846.878828029327;3397.1676939150066;3506.8772592959635;3517.613062563116;3519.1905861651962;3524.4360902255517;590.238592216045;596.9343372229051;606.7906572232573;608.2397003745318;614.6619359352338;550.435803301619;558.3857756467934;657.0702456024767;679.7450955891541;700.3871612339203;9086.545672716338;9128.58921348541;9449.131908211879;9452.52737363129;9839.3112482127;599.9730012149464;637.3467196123918;661.166929668621;692.6329045605837;719.481972979454;4086;4269.487661480643;4429.2027435062;4457.153140903218;4480.7535585542455;131840.3407982954;134601;135229;135677;138735;115633;116870;118211.40894295473;118305;120378.39810801065;103448;103763.4811825936;103842;104895.47552262343;107701.46149269203;7984.20157984197;8498.872516912375;8573.528455934984;8577.35669824778;8663.826723465621;40510.1897962045;49422;54485;57177.42822571721;58632;79686.6015669918;84712;85501.49946696669;86108;89887;11501.270748947674;11544.422778860855;11765.117616178992;11770.52917883275;11819.172657913863;12937;13049.673758156123;13288.601341959757;13508.054436189372;13756.65608359799;12239.388030598613;12422.937885310515;12504.187227830162;12612.43244054038;13156.276404797445;12694.936525317315;13133.802992955305;13260.668483287609;13683.11059781111;13810.37853296584;12287.447064881922;12478;12746.617601471971;12939.158954668294;13057.34713264352;10070.295079344376;10244;10400.375977441377;10480.737981550523;10728;9452.43285402878;9496;9867.851982220416;10114.94942525312;10624.521896514521 06:19:00 INFO - PROCESS | 22961 | __end_tp_report 06:19:00 INFO - PROCESS | 22961 | __start_cc_report 06:19:00 INFO - PROCESS | 22961 | _x_x_mozilla_cycle_collect,340 06:19:00 INFO - PROCESS | 22961 | __end_cc_report 06:19:00 INFO - PROCESS | 22961 | __startTimestamp1470662340617__endTimestamp 06:19:00 INFO - PROCESS | 22961 | 06:19:00 INFO - PROCESS | 22961 | ------- Summary: start ------- 06:19:00 INFO - PROCESS | 22961 | Number of tests: 6 06:19:00 INFO - PROCESS | 22961 | 06:19:00 INFO - PROCESS | 22961 | [#0] dojo.html Cycles:165 Average:5455.29 Median:5695.32 stddev:617.73 (10.8%) stddev-sans-first:592.59 06:19:00 INFO - PROCESS | 22961 | Values: 3151.3 3166.0 3188.9 3191.9 3194.6 5467.5 5498.3 5554.9 5561.7 5583.6 5395.2 5490.6 5513.1 5568.7 5587.1 4705.3 4870.1 4976.1 5030.3 5128.1 5073.4 5083.9 5084.1 5090.6 5147.5 4887.0 4893.9 4903.3 5009.9 5068.0 4930.2 4972.9 4979.1 4984.6 4996.4 4889.9 4952.2 4955.5 4958.9 4989.6 5377.3 5419.4 5439.8 5445.5 5448.3 5839.8 5853.9 5856.8 5862.3 5886.2 5872.6 5873.4 5879.2 5888.8 5891.9 5401.6 5451.7 5454.3 5465.6 5495.1 5988.2 5998.7 6007.3 6011.6 6040.6 5703.3 5734.8 5748.2 5763.0 5772.5 5737.0 5820.4 5860.0 5863.9 5867.8 5851.6 5857.2 5879.9 5885.0 5916.4 5843.6 5860.6 5881.9 5889.5 5901.4 4392.3 4466.2 4472.9 4514.2 4515.9 4003.2 4004.7 4009.3 4045.3 4067.5 5594.2 5611.5 5619.7 5646.9 5649.6 5749.8 5859.1 5895.1 5922.2 5946.9 5622.7 5622.7 5623.2 5633.6 5634.7 5081.5 5083.0 5084.3 5087.3 5142.3 5965.5 6030.1 6048.5 6084.5 6181.0 5832.3 5850.4 5851.8 5882.6 5884.4 6002.2 6042.6 6043.9 6045.2 6046.5 5695.3 5724.4 5729.5 5734.7 5761.5 5878.2 5884.6 5885.0 5901.2 5930.6 5703.7 5745.6 5754.4 5756.3 5763.4 5571.6 5650.7 5710.7 5719.7 5725.8 5742.9 5767.5 5767.7 5801.1 5819.4 5757.6 5777.6 5780.7 5815.3 5817.4 5573.6 5640.8 5654.7 5657.7 5667.3 06:19:00 INFO - PROCESS | 22961 | 06:19:00 INFO - PROCESS | 22961 | [#1] ext.html Cycles:180 Average:65271.96 Median:43404.67 stddev:133817.18 (308.3%) stddev-sans-first:134104.34 06:19:00 INFO - PROCESS | 22961 | Values: 550.5 586.4 600.6 612.1 649.7 38952.8 43407.6 43623.3 43867.8 43949.0 43102.4 43141.8 43401.8 43606.3 43646.1 8844.6 8972.1 8989.1 8991.1 8993.6 8945.0 8949.5 9020.8 9023.6 9029.5 9079.5 9087.7 9133.2 9140.5 9143.1 9004.9 9051.5 9066.5 9067.3 9078.8 8922.2 8949.9 8965.6 8994.1 8996.4 42143.4 42279.8 42490.0 42598.0 42603.4 3426.0 3525.6 3568.6 3669.0 3990.2 33093.5 33614.8 33811.7 33907.8 34722.3 4250.9 4367.5 4401.9 4405.9 4423.4 351119.0 351660.0 352346.0 352746.0 353055.0 59466.4 59706.7 60117.4 60128.4 60213.0 62734.0 62869.7 62908.0 63094.4 63109.7 16670.2 17378.4 17388.9 17886.0 17905.2 13243.1 13259.9 13299.4 13309.6 13332.4 19564.7 19770.3 19787.3 19937.3 20030.3 6936.5 7000.5 7103.9 7140.3 7561.5 982.9 1060.4 1113.8 1114.6 1148.7 33031.3 33184.0 33195.4 33325.3 33536.0 1092.9 1132.6 1147.5 1152.6 1198.4 17103.2 17190.5 17273.1 17413.2 17468.4 618926.0 621576.0 621867.0 625101.0 625316.0 40327.6 40429.6 40621.6 40746.8 60999.0 1317.4 1367.4 1371.1 1385.0 1386.0 30720.6 32672.0 32695.5 33048.8 33188.5 54778.7 56298.9 56404.7 63630.4 63631.0 494231.0 495896.0 497129.0 497146.0 499667.0 44843.0 45141.1 45267.3 45763.5 46028.0 49359.3 50111.7 50299.7 50465.7 51585.0 41810.8 42569.6 43247.6 43596.8 44626.6 42425.2 42449.4 43173.8 43640.3 43923.0 42303.6 42474.8 43765.0 43863.0 43950.1 34689.4 37061.2 37367.0 38037.6 38397.8 28579.0 28791.3 28970.5 29054.6 29367.9 06:19:00 INFO - PROCESS | 22961 | 06:19:00 INFO - PROCESS | 22961 | [#2] jquery.html Cycles:180 Average:30443.83 Median:2361.24 stddev:86420.07 (3659.9%) stddev-sans-first:86633.03 06:19:00 INFO - PROCESS | 22961 | Values: 385.4 390.2 404.4 410.7 415.6 18612.5 19547.4 20089.2 20510.4 20522.4 19236.7 19463.9 19881.2 20258.2 20300.2 5446.1 5639.4 5666.4 5672.8 5677.7 5700.3 5705.1 5708.6 5719.8 5723.5 5809.4 5897.6 5921.3 5928.6 5931.9 5422.6 5635.5 5705.9 5766.4 5876.3 5518.3 5556.0 5562.9 5570.4 5582.5 13776.7 13920.0 14165.9 23164.1 23369.2 2208.0 2273.4 2344.0 2378.5 2477.2 10044.9 10131.8 10142.2 10174.1 10194.9 1830.4 1871.4 1910.7 1957.0 1969.8 83094.0 86978.1 87489.6 87600.0 89471.0 10247.4 10429.7 10832.9 10863.7 11107.5 13866.4 13929.4 13973.1 14013.4 14015.6 7762.9 7962.2 8026.0 8195.8 8254.3 7825.8 7918.5 8003.2 8098.2 8109.2 4202.8 4387.5 4598.2 4739.7 4743.2 1923.6 1991.5 2075.7 2093.8 2127.3 914.0 928.6 946.6 960.9 1022.9 19217.8 20573.7 20803.7 20845.6 21049.6 970.0 996.9 1016.7 1027.3 1079.7 10121.5 11580.1 11615.0 11626.2 11645.8 499513.0 520146.0 522576.0 537391.0 537516.0 88686.0 89817.6 98729.0 98747.0 98970.5 987.4 1015.6 1049.3 1050.4 1060.0 18030.8 18370.5 18616.9 18833.0 18846.4 44033.0 44834.8 44950.8 45709.8 46111.0 63348.0 64784.7 65561.7 66049.7 66232.7 8694.6 8828.4 8828.4 8923.1 9212.2 12853.5 13674.2 13822.9 13873.9 14244.8 11670.2 11833.0 11917.8 12222.1 12559.6 12005.3 12076.8 12126.9 12176.8 12566.9 11708.8 11709.8 12107.8 12185.1 12333.6 8586.5 8612.1 8847.0 8883.0 8926.7 10173.7 11136.7 11223.2 12383.1 12420.3 06:19:00 INFO - PROCESS | 22961 | 06:19:00 INFO - PROCESS | 22961 | [#3] mootools.html Cycles:180 Average:5942.88 Median:2662.10 stddev:3406.83 (128.0%) stddev-sans-first:3399.97 06:19:00 INFO - PROCESS | 22961 | Values: 1491.8 1522.5 1635.1 1765.8 1776.3 8043.5 8572.2 8738.0 9274.8 9296.9 8783.2 9120.6 9144.8 9188.5 9222.0 2436.0 2465.9 2485.4 2486.3 2487.8 2384.2 2472.7 2484.8 2487.7 2490.4 2435.6 2436.8 2478.0 2501.1 2502.4 2428.0 2442.2 2443.5 2446.3 2453.6 2414.9 2422.4 2430.3 2435.9 2441.9 9067.3 9086.7 9124.7 9154.9 9155.9 5453.1 5568.6 5591.4 5604.2 5606.4 3403.1 3487.8 3500.9 3545.0 3583.8 1084.2 1127.6 1134.1 1136.7 1150.5 12839.7 12868.4 12900.4 12978.5 12994.2 4736.5 4839.4 4886.8 4888.7 5022.8 10765.1 10765.9 10766.2 10829.1 10832.2 5539.4 5580.2 5604.2 5608.1 5611.3 4460.1 4914.9 5027.4 5052.8 5141.1 4082.4 4100.9 4182.9 4226.9 4230.9 1308.4 1338.4 1350.3 1352.4 1367.9 821.4 920.7 936.4 952.2 966.9 5909.5 5980.7 5988.3 6000.5 6084.3 431.2 464.7 480.6 484.8 485.1 3967.0 4077.2 4136.5 4138.9 4140.1 11037.2 11354.5 11395.1 11427.3 11431.7 11124.0 11200.3 11249.6 11350.4 11380.7 8219.6 8348.9 8379.4 8389.4 8400.3 5650.4 5832.7 5857.6 5871.7 5942.4 10224.1 10276.4 10321.5 10370.9 10371.2 10578.5 10593.2 10597.6 10654.5 10705.3 7058.4 7440.8 7469.8 8055.5 8147.0 8533.6 8567.1 8602.7 8610.4 8625.8 7109.5 7376.6 7381.8 7399.6 7490.2 7438.0 7556.7 7581.4 7668.3 7946.6 6980.2 7100.2 7110.9 7111.6 7139.7 5307.6 5311.0 5360.0 5389.9 5573.8 5243.3 5291.7 5346.8 5378.4 5577.8 06:19:00 INFO - PROCESS | 22961 | 06:19:00 INFO - PROCESS | 22961 | [#4] prototype.html Cycles:180 Average:4710.97 Median:5231.79 stddev:1364.97 (26.1%) stddev-sans-first:1328.64 06:19:00 INFO - PROCESS | 22961 | Values: 332.0 333.5 340.9 342.6 345.4 5437.6 5445.4 5609.7 5687.5 5731.2 5459.2 5523.7 5538.7 5541.5 5570.0 4357.6 4367.8 4373.6 4400.3 4424.8 4079.2 4319.0 4350.4 4398.0 4410.5 4281.0 4282.5 4286.3 4288.7 4296.2 4245.9 4277.8 4285.3 4307.4 4324.8 3580.4 3777.5 3786.4 3799.9 3804.2 5356.5 5401.9 5429.8 5456.0 5468.2 4919.7 4927.0 4927.0 4927.7 4942.7 5520.9 5811.5 5835.5 5848.9 5852.9 4142.7 4149.1 4150.2 4161.8 4164.1 6044.3 6083.5 6119.8 6134.8 6152.2 4155.6 4182.5 4222.6 4255.8 4259.3 4260.0 4277.6 4294.2 4299.9 4300.5 4921.9 4926.0 4928.5 4931.8 4973.1 5737.3 5851.0 5876.6 5901.8 5927.6 1476.3 1491.6 1492.3 1493.9 1498.5 887.4 932.8 939.8 950.1 952.3 4886.5 4928.7 4929.5 4930.6 4996.6 5203.5 5212.9 5250.7 5255.5 5267.6 4621.3 4894.7 4961.5 4980.0 4998.9 2792.4 2806.5 2811.7 2822.9 2827.7 5474.5 5490.9 5494.2 5503.7 5536.0 5165.3 5363.3 5386.4 5391.5 5427.2 5403.5 5421.5 5432.9 5447.8 5461.4 5014.6 5175.3 5190.5 5251.4 5269.8 5079.7 5126.3 5173.3 5174.6 5187.0 5396.0 5399.5 5420.5 5441.6 5443.8 3981.7 4169.5 4238.7 4309.0 4316.1 5964.1 5976.5 5989.6 5997.8 6000.7 5666.4 5829.9 5840.0 5843.5 5894.5 5707.8 5752.1 5752.4 5786.3 5808.8 5761.5 5819.4 5823.9 5826.4 5832.7 5668.5 5815.8 5824.5 5866.5 5885.6 5681.9 5713.9 5720.6 5752.5 5759.9 06:19:00 INFO - PROCESS | 22961 | 06:19:00 INFO - PROCESS | 22961 | [#5] yui.html Cycles:180 Average:23067.50 Median:4443.18 stddev:35844.93 (806.7%) stddev-sans-first:35906.44 06:19:00 INFO - PROCESS | 22961 | Values: 784.6 793.2 803.6 823.2 843.9 14837.0 15628.3 15643.5 15667.5 15791.1 14080.1 14149.0 14189.0 14194.5 14195.0 662.4 782.5 797.8 811.9 826.2 812.8 823.1 823.4 823.4 827.2 879.7 879.8 882.2 882.4 883.0 872.1 876.6 880.4 880.5 880.7 634.3 638.3 638.9 639.0 640.5 15374.5 15482.5 15493.2 15513.8 15520.6 12978.9 13438.7 13719.0 13884.6 16153.6 13816.5 13861.6 13986.9 14029.5 14123.3 4523.1 4532.3 4573.1 4767.5 4786.2 93308.0 94109.1 94123.0 95881.5 95889.0 11621.7 11642.3 11658.2 11701.1 11826.3 21693.6 21819.0 21822.9 21900.0 22161.4 8254.1 8317.7 8327.9 8401.9 8457.7 4637.5 4657.5 4732.6 4784.0 4846.9 3397.2 3506.9 3517.6 3519.2 3524.4 590.2 596.9 606.8 608.2 614.7 550.4 558.4 657.1 679.7 700.4 9086.5 9128.6 9449.1 9452.5 9839.3 600.0 637.3 661.2 692.6 719.5 4086.0 4269.5 4429.2 4457.2 4480.8 131840.3 134601.0 135229.0 135677.0 138735.0 115633.0 116870.0 118211.4 118305.0 120378.4 103448.0 103763.5 103842.0 104895.5 107701.5 7984.2 8498.9 8573.5 8577.4 8663.8 40510.2 49422.0 54485.0 57177.4 58632.0 79686.6 84712.0 85501.5 86108.0 89887.0 11501.3 11544.4 11765.1 11770.5 11819.2 12937.0 13049.7 13288.6 13508.1 13756.7 12239.4 12422.9 12504.2 12612.4 13156.3 12694.9 13133.8 13260.7 13683.1 13810.4 12287.4 12478.0 12746.6 12939.2 13057.3 10070.3 10244.0 10400.4 10480.7 10728.0 9452.4 9496.0 9867.9 10114.9 10624.5 06:19:00 INFO - PROCESS | 22961 | -------- Summary: end -------- 06:19:00 INFO - PROCESS | 22961 | 06:19:01 INFO - TEST-INFO | 22961: exit 0 06:19:01 INFO - TEST-OK | dromaeo_css | took 1113652ms 06:19:01 INFO - TEST-START | kraken 06:19:01 INFO - operating with platform_type : linux_ 06:19:01 INFO - Initialising browser for kraken test... 06:19:01 INFO - TEST-INFO | started process 23214 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdgQu_d/profile http://localhost:41585/getInfo.html) 06:19:06 INFO - PROCESS | 23214 | __metrics Screen width/height:1600/1200 06:19:06 INFO - PROCESS | 23214 | colorDepth:24 06:19:06 INFO - PROCESS | 23214 | Browser inner width/height: 1024/697 06:19:06 INFO - PROCESS | 23214 | __metrics 06:19:07 ERROR - PROCESS | 23214 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 06:19:08 INFO - TEST-INFO | 23214: exit 0 06:19:08 INFO - Browser initialized. 06:19:08 INFO - Running cycle 1/1 for kraken test... 06:19:08 INFO - TEST-INFO | started process 23335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdgQu_d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:19:19 INFO - PROCESS | 23335 | RSS: Main: 164167680 06:19:19 INFO - PROCESS | 23335 | 06:19:22 INFO - PROCESS | 23335 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41585/tests/kraken/driver.html?testName=audio-beat-detection) 06:19:23 INFO - PROCESS | 23335 | RSS: Main: 170020864 06:19:23 INFO - PROCESS | 23335 | 06:19:25 INFO - PROCESS | 23335 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41585/tests/kraken/driver.html?testName=audio-dft) 06:19:26 INFO - PROCESS | 23335 | RSS: Main: 168546304 06:19:26 INFO - PROCESS | 23335 | 06:19:29 INFO - PROCESS | 23335 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41585/tests/kraken/driver.html?testName=audio-fft) 06:19:30 INFO - PROCESS | 23335 | RSS: Main: 164864000 06:19:30 INFO - PROCESS | 23335 | 06:19:32 INFO - PROCESS | 23335 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41585/tests/kraken/driver.html?testName=audio-oscillator) 06:19:32 INFO - PROCESS | 23335 | RSS: Main: 165613568 06:19:32 INFO - PROCESS | 23335 | 06:19:34 INFO - PROCESS | 23335 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41585/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:19:35 INFO - PROCESS | 23335 | RSS: Main: 165724160 06:19:35 INFO - PROCESS | 23335 | 06:19:38 INFO - PROCESS | 23335 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41585/tests/kraken/driver.html?testName=imaging-darkroom) 06:19:39 INFO - PROCESS | 23335 | RSS: Main: 165109760 06:19:39 INFO - PROCESS | 23335 | 06:19:42 INFO - PROCESS | 23335 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41585/tests/kraken/driver.html?testName=imaging-desaturate) 06:19:43 INFO - PROCESS | 23335 | RSS: Main: 163450880 06:19:43 INFO - PROCESS | 23335 | 06:19:46 INFO - PROCESS | 23335 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41585/tests/kraken/driver.html?testName=json-parse-financial) 06:19:46 INFO - PROCESS | 23335 | RSS: Main: 164294656 06:19:46 INFO - PROCESS | 23335 | 06:19:48 INFO - PROCESS | 23335 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41585/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:19:48 INFO - PROCESS | 23335 | RSS: Main: 164712448 06:19:48 INFO - PROCESS | 23335 | 06:19:50 INFO - PROCESS | 23335 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41585/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:19:51 INFO - PROCESS | 23335 | RSS: Main: 164933632 06:19:51 INFO - PROCESS | 23335 | 06:19:53 INFO - PROCESS | 23335 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41585/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:19:54 INFO - PROCESS | 23335 | RSS: Main: 165928960 06:19:54 INFO - PROCESS | 23335 | 06:19:56 INFO - PROCESS | 23335 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41585/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:19:57 INFO - PROCESS | 23335 | RSS: Main: 164958208 06:19:57 INFO - PROCESS | 23335 | 06:20:00 INFO - PROCESS | 23335 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41585/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:20:00 INFO - PROCESS | 23335 | RSS: Main: 165675008 06:20:00 INFO - PROCESS | 23335 | 06:20:02 INFO - PROCESS | 23335 | Cycle 1(1): loaded http://localhost:41585/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41585/tests/kraken/driver.html?testName=ai-astar) 06:20:02 INFO - PROCESS | 23335 | RSS: Main: 167284736 06:20:02 INFO - PROCESS | 23335 | 06:20:02 INFO - PROCESS | 23335 | __start_tp_report 06:20:02 INFO - PROCESS | 23335 | _x_x_mozilla_page_load 06:20:02 INFO - PROCESS | 23335 | _x_x_mozilla_page_load_details 06:20:02 INFO - PROCESS | 23335 | |i|pagename|runs| 06:20:02 INFO - PROCESS | 23335 | |0;ai-astar;102;112;106;112;111;113;112;111;111;112 06:20:02 INFO - PROCESS | 23335 | |1;audio-beat-detection;152;117;148;172;118;149;146;119;184;119 06:20:02 INFO - PROCESS | 23335 | |2;audio-dft;161;163;165;161;162;167;167;163;163;162 06:20:02 INFO - PROCESS | 23335 | |3;audio-fft;76;75;76;175;78;76;75;76;169;76 06:20:02 INFO - PROCESS | 23335 | |4;audio-oscillator;84;84;148;84;85;84;144;85;84;158 06:20:02 INFO - PROCESS | 23335 | |5;imaging-gaussian-blur;118;117;117;117;118;117;118;117;117;117 06:20:02 INFO - PROCESS | 23335 | |6;imaging-darkroom;146;147;147;146;147;147;147;147;146;148 06:20:02 INFO - PROCESS | 23335 | |7;imaging-desaturate;96;96;95;97;97;96;96;96;95;95 06:20:02 INFO - PROCESS | 23335 | |8;json-parse-financial;52;53;51;51;52;54;51;52;54;51 06:20:02 INFO - PROCESS | 23335 | |9;json-stringify-tinderbox;61;61;61;61;62;61;62;61;61;61 06:20:02 INFO - PROCESS | 23335 | |10;stanford-crypto-aes;78;78;76;77;76;75;78;76;81;76 06:20:02 INFO - PROCESS | 23335 | |11;stanford-crypto-ccm;132;121;146;122;123;131;123;132;124;135 06:20:02 INFO - PROCESS | 23335 | |12;stanford-crypto-pbkdf2;167;157;162;158;163;160;168;161;156;160 06:20:02 INFO - PROCESS | 23335 | |13;stanford-crypto-sha256-iterative;63;64;66;63;66;67;63;63;62;66 06:20:02 INFO - PROCESS | 23335 | __end_tp_report 06:20:02 INFO - PROCESS | 23335 | __start_cc_report 06:20:02 INFO - PROCESS | 23335 | _x_x_mozilla_cycle_collect,877 06:20:02 INFO - PROCESS | 23335 | __end_cc_report 06:20:02 INFO - PROCESS | 23335 | __startTimestamp1470662402676__endTimestamp 06:20:02 INFO - PROCESS | 23335 | 06:20:02 INFO - PROCESS | 23335 | ------- Summary: start ------- 06:20:02 INFO - PROCESS | 23335 | Number of tests: 14 06:20:02 INFO - PROCESS | 23335 | 06:20:02 INFO - PROCESS | 23335 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.00 stddev:3.46 (3.1%) stddev-sans-first:2.03 06:20:02 INFO - PROCESS | 23335 | Values: 102.0 112.0 106.0 112.0 111.0 113.0 112.0 111.0 111.0 112.0 06:20:02 INFO - PROCESS | 23335 | 06:20:02 INFO - PROCESS | 23335 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:148.50 stddev:23.86 (16.1%) stddev-sans-first:25.05 06:20:02 INFO - PROCESS | 23335 | Values: 152.0 117.0 148.0 172.0 118.0 149.0 146.0 119.0 184.0 119.0 06:20:02 INFO - PROCESS | 23335 | 06:20:02 INFO - PROCESS | 23335 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.22 (1.4%) stddev-sans-first:2.18 06:20:02 INFO - PROCESS | 23335 | Values: 161.0 163.0 165.0 161.0 162.0 167.0 167.0 163.0 163.0 162.0 06:20:02 INFO - PROCESS | 23335 | 06:20:02 INFO - PROCESS | 23335 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.00 stddev:40.51 (53.3%) stddev-sans-first:42.37 06:20:02 INFO - PROCESS | 23335 | Values: 76.0 75.0 76.0 175.0 78.0 76.0 75.0 76.0 169.0 76.0 06:20:02 INFO - PROCESS | 23335 | 06:20:02 INFO - PROCESS | 23335 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:84.00 stddev:31.93 (38.0%) stddev-sans-first:33.03 06:20:02 INFO - PROCESS | 23335 | Values: 84.0 84.0 148.0 84.0 85.0 84.0 144.0 85.0 84.0 158.0 06:20:02 INFO - PROCESS | 23335 | 06:20:02 INFO - PROCESS | 23335 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 06:20:02 INFO - PROCESS | 23335 | Values: 118.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 06:20:02 INFO - PROCESS | 23335 | 06:20:02 INFO - PROCESS | 23335 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 06:20:02 INFO - PROCESS | 23335 | Values: 146.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 146.0 148.0 06:20:02 INFO - PROCESS | 23335 | 06:20:02 INFO - PROCESS | 23335 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 06:20:02 INFO - PROCESS | 23335 | Values: 96.0 96.0 95.0 97.0 97.0 96.0 96.0 96.0 95.0 95.0 06:20:02 INFO - PROCESS | 23335 | 06:20:02 INFO - PROCESS | 23335 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:1.20 (2.3%) stddev-sans-first:1.27 06:20:02 INFO - PROCESS | 23335 | Values: 52.0 53.0 51.0 51.0 52.0 54.0 51.0 52.0 54.0 51.0 06:20:02 INFO - PROCESS | 23335 | 06:20:02 INFO - PROCESS | 23335 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 06:20:02 INFO - PROCESS | 23335 | Values: 61.0 61.0 61.0 61.0 62.0 61.0 62.0 61.0 61.0 61.0 06:20:02 INFO - PROCESS | 23335 | 06:20:02 INFO - PROCESS | 23335 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:77.50 stddev:1.73 (2.2%) stddev-sans-first:1.80 06:20:02 INFO - PROCESS | 23335 | Values: 78.0 78.0 76.0 77.0 76.0 75.0 78.0 76.0 81.0 76.0 06:20:02 INFO - PROCESS | 23335 | 06:20:02 INFO - PROCESS | 23335 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:131.50 stddev:7.87 (6.0%) stddev-sans-first:8.26 06:20:02 INFO - PROCESS | 23335 | Values: 132.0 121.0 146.0 122.0 123.0 131.0 123.0 132.0 124.0 135.0 06:20:02 INFO - PROCESS | 23335 | 06:20:02 INFO - PROCESS | 23335 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:161.50 stddev:3.97 (2.5%) stddev-sans-first:3.61 06:20:02 INFO - PROCESS | 23335 | Values: 167.0 157.0 162.0 158.0 163.0 160.0 168.0 161.0 156.0 160.0 06:20:02 INFO - PROCESS | 23335 | 06:20:02 INFO - PROCESS | 23335 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:65.00 stddev:1.77 (2.7%) stddev-sans-first:1.81 06:20:02 INFO - PROCESS | 23335 | Values: 63.0 64.0 66.0 63.0 66.0 67.0 63.0 63.0 62.0 66.0 06:20:02 INFO - PROCESS | 23335 | -------- Summary: end -------- 06:20:02 INFO - PROCESS | 23335 | 06:20:03 INFO - TEST-INFO | 23335: exit 0 06:20:03 INFO - TEST-OK | kraken | took 62290ms 06:20:03 INFO - SUITE-END | took 1175s 06:20:03 INFO - Completed test suite (00:19:36) 06:20:03 INFO - javascript benchmark 06:20:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7375.6282637534405, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3151.3382189740155, 3165.9683403165964, 3188.856501457434, 3191.888283910064, 3194.5687332210146, 5467.507924286813, 5498.340199176099, 5554.888902221958, 5561.666300022001, 5583.553315734742, 5395.190721391793, 5490.6431081979745, 5513.09034009388, 5568.6658800472, 5587.1339942308905, 4705.294205869112, 4870.147724148278, 4976.104301225778, 5030.295758593781, 5128.05131050755, 5073.441921388663, 5083.898322033557, 5084.110280700881, 5090.643654944155, 5147.48525147486, 4886.9511304886855, 4893.902121957576, 4903.338049363361, 5009.949900500985, 5067.974660126676, 4930.186519224324, 4972.90054198914, 4979.0788704089855, 4984.551390374883, 4996.375453068366, 4889.902201955941, 4952.232403977389, 4955.4548999610015, 4958.925616115761, 4989.57588604969, 5377.300950876361, 5419.403865574784, 5439.782408703647, 5445.482679145475, 5448.318960129984, 5839.824805255849, 5853.882922341572, 5856.76572937082, 5862.325832529271, 5886.234789477383, 5872.559558033122, 5873.383294754075, 5879.176915231871, 5888.793892213752, 5891.911621325684, 5401.621886467949, 5451.672899626035, 5454.3454785426, 5465.59008074396, 5495.120780675073, 5988.161657367972, 5998.730057147439, 6007.339192688801, 6011.639301641828, 6040.637561746309, 5703.258576385043, 5734.827955161351, 5748.166515855261, 5762.971185144132, 5772.509336706427, 5737.0, 5820.447057529528, 5860.0, 5863.853403664943, 5867.765289388377, 5851.590388672837, 5857.15071314657, 5879.911801322984, 5885.028970219866, 5916.437938395846, 5843.590948633555, 5860.560457965669, 5881.882362352729, 5889.469947704727, 5901.380355062743, 4392.3191905254735, 4466.1514312281215, 4472.865814025585, 4514.187446259639, 4515.932261016087, 4003.2393845169327, 4004.739691920074, 4009.3384591542067, 4045.292073887058, 4067.5322337930925, 5594.244776955059, 5611.466910643482, 5619.662820230799, 5646.858828529237, 5649.632773869767, 5749.8275051748515, 5859.121131830259, 5895.145203945404, 5922.230110085661, 5946.881062378815, 5622.718864056781, 5622.746976386073, 5623.212750214973, 5633.605647604629, 5634.690092044977, 5081.4918508148885, 5083.0, 5084.288199652052, 5087.313212716236, 5142.331496905378, 5965.492933100648, 6030.065339872239, 6048.455638992512, 6084.513238940785, 6181.0, 5832.329282132439, 5850.385709500441, 5851.795187168429, 5882.617629854046, 5884.411558844081, 6002.249718785152, 6042.607230530001, 6043.879122417439, 6045.183900173421, 6046.516278697605, 5695.316562012585, 5724.427557244242, 5729.54163666914, 5734.7132643368495, 5761.452661997104, 5878.2358293421585, 5884.617499862667, 5884.970130227279, 5901.173835663097, 5930.555208359304, 5703.657780533182, 5745.569082318759, 5754.424557544379, 5756.30924289088, 5763.36602973681, 5571.60998730085, 5650.745716442688, 5710.714464276686, 5719.656820590778, 5725.770969161187, 5742.913856292075, 5767.509761670305, 5767.68277744728, 5801.071828507418, 5819.388964158702, 5757.568182386254, 5777.595568310178, 5780.682062486436, 5815.273090863642, 5817.418258174149, 5573.554115670818, 5640.774369025357, 5654.6889921054735, 5657.660540367591, 5667.291588551431], "value": 5413.564209367249, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.5105861697853, 586.4282324733383, 600.6036016229289, 612.1154931124526, 649.7336092202198, 38952.805235973814, 43407.56592434075, 43623.34564981528, 43867.78066109673, 43949.0, 43102.353464698055, 43141.784291078504, 43401.78299108508, 43606.34590481145, 43646.12707745843, 8844.601992910302, 8972.057933916944, 8989.101089891024, 8991.10088991099, 8993.550322483883, 8944.955275223647, 8949.507777072258, 9020.774480638003, 9023.593938272794, 9029.548522573878, 9079.500627465486, 9087.681931132413, 9133.17801397874, 9140.54297285133, 9143.08569143087, 9004.864927026067, 9051.547422628875, 9066.546672666373, 9067.274618030542, 9078.77303067422, 8922.241609463203, 8949.910500894974, 8965.641374345018, 8994.10058994102, 8996.415233009833, 42143.36784948228, 42279.7886010571, 42490.0, 42598.0, 42603.36094958578, 3426.0, 3525.5593050868642, 3568.57177138745, 3668.9633103669157, 3990.221906728189, 33093.4536707553, 33614.83192584046, 33811.6618833811, 33907.830460847785, 34722.30555388878, 4250.872473825791, 4367.541408152162, 4401.9119617607785, 4405.911881762347, 4423.380726698265, 351119.0, 351660.0, 352346.0, 352746.0, 353054.99999999744, 59466.40533594609, 59706.70146649326, 60117.39882601118, 60128.39871601316, 60213.0, 62734.0, 62869.74260514764, 62908.0, 63094.369056308846, 63109.68445157745, 16670.16649167537, 17378.39175628847, 17388.91305543464, 17886.0, 17905.19426625805, 13243.139195952232, 13259.933700331436, 13299.401526931311, 13309.600711978655, 13332.400041998133, 19564.652241730797, 19770.30803921856, 19787.30744423938, 19937.302194423417, 20030.298939537046, 6936.4797640177185, 7000.474964377692, 7103.92896071043, 7140.285971402922, 7561.508501947355, 982.8967958364269, 1060.4273692206277, 1113.821788513834, 1114.5541783286587, 1148.661144962238, 33031.33937321288, 33184.0, 33195.40183986298, 33325.33349333, 33536.0, 1092.9016388525072, 1132.5809450503366, 1147.5467190459722, 1152.6196355202762, 1198.394810620631, 17103.23035463407, 17190.484285471455, 17273.136343182792, 17413.216405261795, 17468.388606398716, 618926.0, 621576.0, 621867.0, 625101.0, 625316.0, 40327.59672403297, 40429.595704043175, 40621.593784062374, 40746.79626601848, 60999.0, 1317.4466723975954, 1367.3505085084505, 1371.1087792934673, 1384.9861501385058, 1385.958421247344, 30720.623890819465, 32672.0, 32695.50956735603, 33048.834755826065, 33188.51954986046, 54778.72610637081, 56298.90356030458, 56404.717976409855, 63630.36369636429, 63631.0, 494231.0, 495896.0, 497129.0, 497146.0, 499667.0, 44842.96413322817, 45141.0971780556, 45267.320990185835, 45763.54236457593, 46028.0, 49359.25961110658, 50111.74944125256, 50299.74850125872, 50465.74767126141, 51585.0, 41810.790946045076, 42569.5743042578, 43247.56752432435, 43596.78201608972, 44626.55373446224, 42425.15149696927, 42449.36325955051, 43173.78413107914, 43640.345394819735, 43923.0, 42303.576964229964, 42474.81155310024, 43765.0, 43863.0, 43950.12099758051, 34689.43897524668, 37061.2073574755, 37367.0, 38037.61962380341, 38397.808010959765, 28579.0, 28791.280217994718, 28970.53750431237, 29054.564181536873, 29367.853160734914], "value": 20904.326813151463, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.4218671992012, 390.2059309305562, 404.437831414334, 410.73712823792766, 415.56158253043026, 18612.53468663284, 19547.41357759266, 20089.196432142697, 20510.38468845935, 20522.38432847015, 19236.71144932827, 19463.90268048661, 19881.204751809946, 20258.189672413086, 20300.18799248028, 5446.101393270125, 5639.407862174474, 5666.405027472118, 5672.801451949193, 5677.687727175004, 5700.258966334371, 5705.115707065412, 5708.628939118965, 5719.77120915165, 5723.54211663066, 5809.419058094199, 5897.616654917417, 5921.289445266574, 5928.614640048405, 5931.911021334683, 5422.566194704415, 5635.520980716644, 5705.885882282372, 5766.423357664242, 5876.265466816648, 5518.2826232589905, 5556.0, 5562.888742225133, 5570.387257401682, 5582.525485333752, 13776.65558361049, 13920.0, 14165.929170354082, 23164.073437062496, 23369.182078627335, 2207.9889600552056, 2273.4089136824546, 2343.953120937572, 2378.5242951409787, 2477.2444404456633, 10044.89955100447, 10131.79736405275, 10142.18862490999, 10174.084332410119, 10194.9490252549, 1830.4234166237593, 1871.4479228627588, 1910.6942889137672, 1956.980430195694, 1969.7636283646054, 83094.0, 86978.13021869764, 87489.56255218684, 87600.0, 89471.0, 10247.38515689061, 10429.68710938673, 10832.891671083345, 10863.67408977732, 11107.500162492708, 13866.376013079436, 13929.373178207004, 13973.09174903628, 14013.43946242139, 14015.649608759659, 7762.883556746653, 7962.163972782891, 8026.0, 8195.754127376189, 8254.298384637374, 7825.843483130306, 7918.524888506708, 8003.19968003195, 8098.190180981855, 8109.189081091961, 4202.810873510699, 4387.451568553931, 4598.241290187082, 4739.715617062987, 4743.241081427024, 1923.5768131011155, 1991.541945352577, 2075.73015507983, 2093.8324934005245, 2127.3086246969797, 913.963441462334, 928.5728564860104, 946.6355453150449, 960.9231261499203, 1022.882368527614, 19217.80782192188, 20573.69139462909, 20803.68794468084, 20845.58308833815, 21049.579008419747, 969.9757506062264, 996.9152622027063, 1016.7407311135613, 1027.291169093323, 1079.6707004363745, 10121.493925303705, 11580.131490138105, 11615.0, 11626.186166968231, 11645.767084658259, 499513.0, 520146.0, 522576.0, 537391.0, 537516.0, 88686.0, 89817.55091224502, 98729.0, 98747.0, 98970.5051474738, 987.3878195518824, 1015.6242190389455, 1049.275999560301, 1050.4275170032352, 1059.9682009539727, 18030.819691802913, 18370.540736481697, 18616.936289195233, 18833.0, 18846.43460696181, 44033.0, 44834.77582612066, 44950.77524612356, 45709.77145114386, 46111.0, 63348.0, 64784.67607661932, 65561.67219164064, 66049.66975165093, 66232.6688366555, 8694.565271736514, 8828.38201325901, 8828.38201325901, 8923.107689231025, 9212.216961558343, 12853.485860565472, 13674.247916364695, 13822.861771382157, 13873.930630346784, 14244.786328205293, 11670.241434307083, 11833.0, 11917.761644766882, 12222.144449888423, 12559.560415385418, 12005.313942105831, 12076.818847717115, 12126.869396801267, 12176.817347739969, 12566.874331256937, 11708.765824683629, 11709.824352634887, 12107.81838272409, 12185.147039707135, 12333.62999110028, 8586.527740974307, 8612.138786121588, 8846.955765221133, 8883.0, 8926.68756593516, 10173.745656358355, 11136.721581960515, 11223.214374993671, 12383.071269654993, 12420.254784712946], "value": 9322.213793928817, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1491.8358980512141, 1522.4747462125567, 1635.092523649374, 1765.8057613662486, 1776.2539733312008, 8043.477173983687, 8572.22849943505, 8737.956310218457, 9274.81450370993, 9296.8605470918, 8783.165599268075, 9120.589573469193, 9144.817103657922, 9188.540572971342, 9222.0, 2435.975640243597, 2465.9136930207446, 2485.403503159247, 2486.3286912533604, 2487.8382905111202, 2384.1893756122913, 2472.6909136357954, 2484.8260621756394, 2487.676602041732, 2490.3774056485877, 2435.6468312094735, 2436.8050555955483, 2478.033566908907, 2501.1496091328945, 2502.3744063984004, 2428.0287884846116, 2442.218490083174, 2443.450223699671, 2446.3150317911013, 2453.6074228123503, 2414.9275521734376, 2422.4307287787356, 2430.307362401707, 2435.866027368494, 2441.8645329921674, 9067.319951003701, 9086.727398178065, 9124.680636177769, 9154.86267705985, 9155.862662060075, 5453.100238460649, 5568.638038527482, 5591.3569939456665, 5604.1593760935775, 5606.383297837235, 3403.128329201381, 3487.7907325560545, 3500.929981400383, 3545.042838433634, 3583.802890841003, 1084.203110713625, 1127.5546159267126, 1134.126722423729, 1136.693092864922, 1150.5340337163461, 12839.74320513594, 12868.420921058574, 12900.419481123372, 12978.480860765558, 12994.15537990037, 4736.478987311393, 4839.443464001614, 4886.780094895738, 4888.7311197884455, 5022.7990880365105, 10765.084967777826, 10765.892341076646, 10766.246362754531, 10829.133669306437, 10832.241743078066, 5539.446055394428, 5580.2466666999435, 5604.215409842625, 5608.1027035674915, 5611.298587676541, 4460.085682435158, 4914.90170196594, 5027.371578552681, 5052.8484145475695, 5141.100307446182, 4082.4415378517915, 4100.856470023535, 4182.937255941163, 4226.873193804129, 4230.894227644333, 1308.4112149532557, 1338.3910320804205, 1350.2843492948753, 1352.4454973460834, 1367.856375080622, 821.3675469888273, 920.7007722490217, 936.4334577580465, 952.1953948913157, 966.8694726212012, 5909.527237820964, 5980.66133460663, 5988.311344195473, 6000.519958403317, 6084.30030546484, 431.2345586583839, 464.7443905851768, 480.5962991087503, 484.7527760841996, 485.06382681425185, 3966.960330396717, 4077.2457095436844, 4136.503619565611, 4138.8551400700835, 4140.068484590943, 11037.172212084126, 11354.48904799286, 11395.14536409756, 11427.314361138358, 11431.714207144722, 11123.998840104268, 11200.271982321123, 11249.606263780892, 11350.3757293348, 11380.658580242605, 8219.630116644765, 8348.874766878502, 8379.37154713399, 8389.412741108186, 8400.3199360127, 5650.434956504317, 5832.737526811219, 5857.648541087548, 5871.706414679335, 5942.376050514807, 10224.130948869131, 10276.407156890695, 10321.48392580383, 10370.948145259226, 10371.222158338003, 10578.471076445992, 10593.205509586965, 10597.62908298206, 10654.520546575268, 10705.250632455965, 7058.400035996792, 7440.776776696708, 7469.813254668459, 8055.476394034369, 8146.959265203636, 8533.573321334032, 8567.057623661516, 8602.655893764178, 8610.354223433393, 8625.827483450421, 7109.502334836512, 7376.557406555409, 7381.8154546136775, 7399.630018498946, 7490.176080631018, 7437.962810185914, 7556.697732090654, 7581.355584775135, 7668.309852113337, 7946.642401091849, 6980.162380514168, 7100.183478899786, 7110.857782844418, 7111.644417779194, 7139.678714457758, 5307.628466007497, 5311.0, 5360.0, 5389.946100538945, 5573.7770489179975, 5243.265942767939, 5291.708956007456, 5346.759395827275, 5378.354597448331, 5577.804776832953], "value": 4678.957742005189, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.9502074688798, 333.53305372478525, 340.8977306807957, 342.62653707458867, 345.40072973391176, 5437.619366644337, 5445.428230035848, 5609.663420194791, 5687.544996400288, 5731.168980497825, 5459.188517913278, 5523.7238138093135, 5538.667679939196, 5541.503793975634, 5569.972150139243, 4357.586029327217, 4367.825286988516, 4373.606375426211, 4400.251957167273, 4424.845130420436, 4079.2453396121814, 4318.9784051079705, 4350.412694286279, 4397.956020439787, 4410.536893626171, 4280.978595107035, 4282.528921818597, 4286.314189729644, 4288.69979101463, 4296.162248361571, 4245.87262382129, 4277.786110694484, 4285.314349704033, 4307.418498502709, 4324.762138082404, 3580.445031020196, 3777.452269420946, 3786.3752480840626, 3799.886003419902, 3804.1630841214887, 5356.517913387814, 5401.864953376158, 5429.809956651498, 5456.045192091407, 5468.207109969032, 4919.655624106314, 4926.975365123151, 4926.975365123188, 4927.704337739711, 4942.728149951751, 5520.861978450571, 5811.476967072941, 5835.503982161521, 5848.90008295604, 5852.853678658025, 4142.668586513102, 4149.107941792499, 4150.232207041677, 4161.791910404468, 4164.146349998243, 6044.304904935901, 6083.452489275942, 6119.785807496716, 6134.846628834271, 6152.230971128564, 4155.646770024521, 4182.498100227992, 4222.577742225814, 4255.765932873722, 4259.2759230930815, 4260.0, 4277.615014648634, 4294.162638285567, 4299.871003869889, 4300.505441874225, 4921.892574170783, 4925.975370123127, 4928.507149285043, 4931.802727890916, 4973.1297023020825, 5737.282839645044, 5851.0, 5876.588638795243, 5901.7639294427745, 5927.614705044159, 1476.320892389513, 1491.61963699256, 1492.2986196487634, 1493.873020793223, 1498.5204734485078, 887.3611000079932, 932.7668082979255, 939.8261321655516, 950.1068995144542, 952.2667545989549, 4886.486918873538, 4928.704277743275, 4929.531694489017, 4930.580900623416, 4996.550310472075, 5203.479652034842, 5212.921806172911, 5250.65870718402, 5255.474452554714, 5267.578593712494, 4621.32990716351, 4894.681845680019, 4961.50384961501, 4979.950200498021, 4998.875477921869, 2792.4415116976684, 2806.5088609493255, 2811.718828117172, 2822.8990693629503, 2827.7313655202724, 5474.549244450224, 5490.945090549123, 5494.170502191375, 5503.697296648643, 5536.0, 5165.276861239429, 5363.302770639792, 5386.407495175527, 5391.4608539145775, 5427.15476737911, 5403.486668766461, 5421.512063914267, 5432.891342173134, 5447.836564903059, 5461.433126430492, 5014.620979230741, 5175.275461435327, 5190.455002224712, 5251.422343542131, 5269.841904742864, 5079.6952182869145, 5126.333576635014, 5173.32746742921, 5174.586033117417, 5186.974065129651, 5395.973020134874, 5399.4600539945695, 5420.457954204548, 5441.619086663895, 5443.755031023693, 3981.7212795104065, 4169.457970463942, 4238.660907127484, 4308.978455107705, 4316.136772645421, 5964.061679953946, 5976.462118409364, 5989.580729348903, 5997.820065398045, 6000.669963152069, 5666.405027472056, 5829.883402332014, 5840.0, 5843.539115221195, 5894.498967587803, 5707.800226992035, 5752.073055526445, 5752.424757524214, 5786.33457152416, 5808.796692115756, 5761.5390768739235, 5819.388964158702, 5823.912641310299, 5826.446487583673, 5832.737526811219, 5668.546516278605, 5815.82552523425, 5824.475797178275, 5866.472017518444, 5885.646861188342, 5681.886362272814, 5713.9142912855505, 5720.628159169641, 5752.453516915886, 5759.856003599776], "value": 4275.6509447004, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.6390660296263, 793.1711361627099, 803.5901690138028, 823.1973825520117, 843.9451435656678, 14837.0, 15628.2967266473, 15643.530694079196, 15667.451639192645, 15791.052536847797, 14080.084794488352, 14149.0, 14189.0, 14194.503192388269, 14195.0, 662.4170729757807, 782.4679218131654, 797.752696664036, 811.853866304065, 826.1614461321764, 812.7846120777998, 823.1028179284579, 823.3948048184579, 823.4112609484217, 827.2182787266036, 879.7404765594165, 879.7976465412959, 882.2280504558511, 882.4087861133056, 883.0154377868695, 872.1060912564609, 876.601146478354, 880.3749337970049, 880.5113162194979, 880.6565439478609, 634.346622978333, 638.3201889987149, 638.865838173984, 639.0, 640.4908098062052, 15374.538763837103, 15482.45811396607, 15493.225338733018, 15513.767293490606, 15520.61198470036, 12978.870211297955, 13438.664033399145, 13719.0, 13884.58346249604, 16153.596160095974, 13816.516421925184, 13861.584152475441, 13986.93006534971, 14029.508967186202, 14123.293835308194, 4523.117991991563, 4532.297493888453, 4573.062522182944, 4767.523247675239, 4786.16242157621, 93308.0, 94109.05890941071, 94123.0, 95881.5205923966, 95889.0, 11621.6513504595, 11642.281899139247, 11658.242214256215, 11701.063914886789, 11826.349550774617, 21693.56612867734, 21819.0, 21822.890885545472, 21900.0, 22161.445963851034, 8254.133316001853, 8317.708880189286, 8327.916720832714, 8401.915980840236, 8457.661693532313, 4637.489876113625, 4657.46439159501, 4732.597729193058, 4783.976080119577, 4846.878828029327, 3397.1676939150066, 3506.8772592959635, 3517.613062563116, 3519.1905861651962, 3524.4360902255517, 590.238592216045, 596.9343372229051, 606.7906572232573, 608.2397003745318, 614.6619359352338, 550.435803301619, 558.3857756467934, 657.0702456024767, 679.7450955891541, 700.3871612339203, 9086.545672716338, 9128.58921348541, 9449.131908211879, 9452.52737363129, 9839.3112482127, 599.9730012149464, 637.3467196123918, 661.166929668621, 692.6329045605837, 719.481972979454, 4086.0, 4269.487661480643, 4429.2027435062, 4457.153140903218, 4480.7535585542455, 131840.3407982954, 134601.0, 135229.0, 135677.0, 138735.0, 115633.0, 116870.0, 118211.40894295473, 118305.0, 120378.39810801065, 103448.0, 103763.4811825936, 103842.0, 104895.47552262343, 107701.46149269203, 7984.20157984197, 8498.872516912375, 8573.528455934984, 8577.35669824778, 8663.826723465621, 40510.1897962045, 49422.0, 54485.0, 57177.42822571721, 58632.0, 79686.6015669918, 84712.0, 85501.49946696669, 86108.0, 89887.0, 11501.270748947674, 11544.422778860855, 11765.117616178992, 11770.52917883275, 11819.172657913863, 12937.0, 13049.673758156123, 13288.601341959757, 13508.054436189372, 13756.65608359799, 12239.388030598613, 12422.937885310515, 12504.187227830162, 12612.43244054038, 13156.276404797445, 12694.936525317315, 13133.802992955305, 13260.668483287609, 13683.11059781111, 13810.37853296584, 12287.447064881922, 12478.0, 12746.617601471971, 12939.158954668294, 13057.34713264352, 10070.295079344376, 10244.0, 10400.375977441377, 10480.737981550523, 10728.0, 9452.43285402878, 9496.0, 9867.851982220416, 10114.94942525312, 10624.521896514521], "value": 7627.085287285465, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 106.0, 112.0, 111.0, 113.0, 112.0, 111.0, 111.0, 112.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 117.0, 148.0, 172.0, 118.0, 149.0, 146.0, 119.0, 184.0, 119.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 165.0, 161.0, 162.0, 167.0, 167.0, 163.0, 163.0, 162.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 175.0, 78.0, 76.0, 75.0, 76.0, 169.0, 76.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 148.0, 84.0, 85.0, 84.0, 144.0, 85.0, 84.0, 158.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 148.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 97.0, 97.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 51.0, 51.0, 52.0, 54.0, 51.0, 52.0, 54.0, 51.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 62.0, 61.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 76.0, 77.0, 76.0, 75.0, 78.0, 76.0, 81.0, 76.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 121.0, 146.0, 122.0, 123.0, 131.0, 123.0, 132.0, 124.0, 135.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 157.0, 162.0, 158.0, 163.0, 160.0, 168.0, 161.0, 156.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 66.0, 63.0, 66.0, 67.0, 63.0, 63.0, 62.0, 66.0], "value": 64.3, "unit": "score"}]}]} 06:20:03 INFO - Return code: 0 06:20:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:20:03 ERROR - # TBPL SUCCESS # 06:20:03 INFO - Running post-action listener: _resource_record_post_action 06:20:03 INFO - [mozharness: 2016-08-08 13:20:03.977070Z] Finished run-tests step (success) 06:20:03 INFO - Running post-run listener: _resource_record_post_run 06:20:04 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 546242560; Read time: 20; Write time: 1200384 06:20:04 INFO - TinderboxPrint: CPU usage
13.5% 06:20:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 06:20:04 INFO - TinderboxPrint: I/O write bytes / time
546,242,560 / 1,200,384 06:20:04 INFO - TinderboxPrint: CPU idle
8,237.6 (86.5%) 06:20:04 INFO - TinderboxPrint: CPU user
1,214.6 (12.8%) 06:20:04 INFO - TinderboxPrint: Swap in / out
0 / 0 06:20:04 INFO - install - Wall time: 17s; CPU: 17.0%; Read bytes: 0; Write bytes: 251822080; Read time: 0; Write time: 660512 06:20:04 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 287690752; Read time: 0; Write time: 538212 06:20:04 INFO - Running post-run listener: _upload_blobber_files 06:20:04 INFO - Blob upload gear active. 06:20:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:20:04 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 06:20:04 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:20:04 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:20:05 INFO - (blobuploader) - INFO - Open directory for files ... 06:20:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:20:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:20:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:05 INFO - (blobuploader) - INFO - Done attempting. 06:20:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:20:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:20:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:10 INFO - (blobuploader) - INFO - Done attempting. 06:20:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:20:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:20:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:11 INFO - (blobuploader) - INFO - Done attempting. 06:20:11 INFO - (blobuploader) - INFO - Iteration through files over. 06:20:11 INFO - Return code: 0 06:20:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:20:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:20:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98d6695a322f80aa4c752b62609a0e92f1b17c4d86a0b7cec979ffd17a95b2ee3d5def84b5461ac159b98044dde25c767e5eebde16772d87cb996a7c4d21b7a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25141057fa8f4e868d998517f43b30c5bef992a23c9451d8defb015af7f1805a8007fa0f0e5801d80e57f011264291bf9421f98ddf335f8d24853422d1329c35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6663d9ce23cee36a482183dd27472bde1ad3737f4f1135cb05858db95fe19a22ad0f33b4c749a6db00ced03a7671cfb27dbf70f42757c875f800b0287584701f"} 06:20:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:20:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:20:11 INFO - Contents: 06:20:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98d6695a322f80aa4c752b62609a0e92f1b17c4d86a0b7cec979ffd17a95b2ee3d5def84b5461ac159b98044dde25c767e5eebde16772d87cb996a7c4d21b7a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25141057fa8f4e868d998517f43b30c5bef992a23c9451d8defb015af7f1805a8007fa0f0e5801d80e57f011264291bf9421f98ddf335f8d24853422d1329c35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6663d9ce23cee36a482183dd27472bde1ad3737f4f1135cb05858db95fe19a22ad0f33b4c749a6db00ced03a7671cfb27dbf70f42757c875f800b0287584701f"} 06:20:11 INFO - Running post-run listener: copy_logs_to_upload_dir 06:20:11 INFO - Copying logs to upload dir... 06:20:11 INFO - mkdir: /builds/slave/test/build/upload/logs 06:20:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.900257 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-08-08 06:20:11.066797) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 06:20:11.070756) ========= 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=8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212 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/Fx-Team/sha512/98d6695a322f80aa4c752b62609a0e92f1b17c4d86a0b7cec979ffd17a95b2ee3d5def84b5461ac159b98044dde25c767e5eebde16772d87cb996a7c4d21b7a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25141057fa8f4e868d998517f43b30c5bef992a23c9451d8defb015af7f1805a8007fa0f0e5801d80e57f011264291bf9421f98ddf335f8d24853422d1329c35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6663d9ce23cee36a482183dd27472bde1ad3737f4f1135cb05858db95fe19a22ad0f33b4c749a6db00ced03a7671cfb27dbf70f42757c875f800b0287584701f"} build_url:https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011148 build_url: 'https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98d6695a322f80aa4c752b62609a0e92f1b17c4d86a0b7cec979ffd17a95b2ee3d5def84b5461ac159b98044dde25c767e5eebde16772d87cb996a7c4d21b7a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25141057fa8f4e868d998517f43b30c5bef992a23c9451d8defb015af7f1805a8007fa0f0e5801d80e57f011264291bf9421f98ddf335f8d24853422d1329c35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6663d9ce23cee36a482183dd27472bde1ad3737f4f1135cb05858db95fe19a22ad0f33b4c749a6db00ced03a7671cfb27dbf70f42757c875f800b0287584701f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 06:20:11.096003) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 06:20:11.096337) ========= 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=8783db0840cc980e80bb0bd400000236-1470661176.944637-1211585212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 06:20:11.182352) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 06:20:11.182655) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 06:20:11.183047) ========= ========= Total master_lag: 0.18 =========