builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1467994278.1 results: success (0) buildid: 20160708063001 builduid: 08b88e420ffa4861ba474cb33f4a1cb4 revision: a74a1865eb97f56ca13947e1f62790ab0454c372 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 09:11:18.104463) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 09:11:18.105563) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 09:11:18.106038) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 09:11:18.211572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 09:11:18.211931) ========= 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=6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 09:11:18-- 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% 221M=0s 2016-07-08 09:11:18 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087114 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 09:11:18.314054) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 09:11:18.314391) ========= 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=6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017195 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 09:11:18.364310) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 09:11:18.364669) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev a74a1865eb97f56ca13947e1f62790ab0454c372 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev a74a1865eb97f56ca13947e1f62790ab0454c372 --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=6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 09:11:18,768 truncating revision to first 12 chars 2016-07-08 09:11:18,768 Setting DEBUG logging. 2016-07-08 09:11:18,768 attempt 1/10 2016-07-08 09:11:18,768 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/a74a1865eb97?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 09:11:19,067 unpacking tar archive at: autoland-a74a1865eb97/testing/mozharness/ program finished with exit code 0 elapsedTime=0.620671 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 09:11:19.001159) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 09:11:19.001528) ========= script_repo_revision: a74a1865eb97f56ca13947e1f62790ab0454c372 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 09:11:19.001957) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 09:11:19.002232) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 09:11:19.013029) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-08 09:11:19.013341) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:11:19 INFO - MultiFileLogger online at 20160708 09:11:19 in /builds/slave/test 09:11:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 09:11:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:11:19 INFO - {'append_to_log': False, 09:11:19 INFO - 'base_work_dir': '/builds/slave/test', 09:11:19 INFO - 'blob_upload_branch': 'Autoland', 09:11:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:11:19 INFO - 'branch': 'Autoland', 09:11:19 INFO - 'buildbot_json_path': 'buildprops.json', 09:11:19 INFO - 'config_files': ('talos/linux_config.py',), 09:11:19 INFO - 'default_actions': ('clobber', 09:11:19 INFO - 'read-buildbot-config', 09:11:19 INFO - 'download-and-extract', 09:11:19 INFO - 'populate-webroot', 09:11:19 INFO - 'create-virtualenv', 09:11:19 INFO - 'install', 09:11:19 INFO - 'run-tests'), 09:11:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:11:19 INFO - 'download_minidump_stackwalk': True, 09:11:19 INFO - 'download_symbols': 'ondemand', 09:11:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:11:19 INFO - 'tooltool.py': '/tools/tooltool.py', 09:11:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:11:19 INFO - '/tools/misc-python/virtualenv.py')}, 09:11:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:11:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:11:19 INFO - 'installer_path': 'installer.exe', 09:11:19 INFO - 'log_level': 'info', 09:11:19 INFO - 'log_name': 'talos', 09:11:19 INFO - 'log_to_console': True, 09:11:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:11:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:11:19 INFO - 'opt_config_files': (), 09:11:19 INFO - 'pip_index': False, 09:11:19 INFO - 'sps_profile': False, 09:11:19 INFO - 'sps_profile_interval': 0, 09:11:19 INFO - 'suite': 'dromaeojs', 09:11:19 INFO - 'system_bits': '32', 09:11:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:11:19 INFO - 'title': 'talos-linux64-ix-050', 09:11:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:11:19 INFO - 'use_talos_json': True, 09:11:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:11:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:11:19 INFO - 'work_dir': 'build'} 09:11:19 INFO - ##### 09:11:19 INFO - ##### Running clobber step. 09:11:19 INFO - ##### 09:11:19 INFO - Running pre-action listener: _resource_record_pre_action 09:11:19 INFO - Running main action method: clobber 09:11:19 INFO - rmtree: /builds/slave/test/build 09:11:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:11:20 INFO - Running post-action listener: _resource_record_post_action 09:11:20 INFO - ##### 09:11:20 INFO - ##### Finished clobber step (success) 09:11:20 INFO - ##### 09:11:20 INFO - ##### 09:11:20 INFO - ##### Running read-buildbot-config step. 09:11:20 INFO - ##### 09:11:20 INFO - Running pre-action listener: _resource_record_pre_action 09:11:20 INFO - Running main action method: read_buildbot_config 09:11:20 INFO - Using buildbot properties: 09:11:20 INFO - { 09:11:20 INFO - "project": "", 09:11:20 INFO - "product": "firefox", 09:11:20 INFO - "script_repo_revision": "production", 09:11:20 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 09:11:20 INFO - "repository": "", 09:11:20 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 09:11:20 INFO - "buildid": "20160708063001", 09:11:20 INFO - "pgo_build": "True", 09:11:20 INFO - "basedir": "/builds/slave/test", 09:11:20 INFO - "buildnumber": 25, 09:11:20 INFO - "slavename": "talos-linux64-ix-050", 09:11:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:11:20 INFO - "platform": "ubuntu64_hw", 09:11:20 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 09:11:20 INFO - "branch": "autoland", 09:11:20 INFO - "repo_path": "integration/autoland", 09:11:20 INFO - "revision": "a74a1865eb97f56ca13947e1f62790ab0454c372", 09:11:20 INFO - "stage_platform": "linux64-pgo", 09:11:20 INFO - "builduid": "08b88e420ffa4861ba474cb33f4a1cb4", 09:11:20 INFO - "slavebuilddir": "test" 09:11:20 INFO - } 09:11:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:11:20 INFO - Running post-action listener: _resource_record_post_action 09:11:20 INFO - ##### 09:11:20 INFO - ##### Finished read-buildbot-config step (success) 09:11:20 INFO - ##### 09:11:20 INFO - ##### 09:11:20 INFO - ##### Running download-and-extract step. 09:11:20 INFO - ##### 09:11:20 INFO - Running pre-action listener: _resource_record_pre_action 09:11:20 INFO - Running main action method: download_and_extract 09:11:20 INFO - mkdir: /builds/slave/test/build/tests 09:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:20 INFO - https://queue.taskcluster.net/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:11:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:11:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:11:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:11:28 INFO - Downloaded 1361 bytes. 09:11:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:11:28 INFO - Using the following test package requirements: 09:11:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:11:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:11:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:11:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:28 INFO - u'jsshell-linux-x86_64.zip'], 09:11:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:11:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:11:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:11:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:11:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:11:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:11:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:28 INFO - https://queue.taskcluster.net/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:11:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:11:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:11:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:11:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:11:33 INFO - Downloaded 24304265 bytes. 09:11:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:11:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:11:34 INFO - Return code: 0 09:11:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:34 INFO - https://queue.taskcluster.net/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:11:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:11:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:11:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:11:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:11:35 INFO - Downloaded 24304265 bytes. 09:11:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:11:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:11:36 INFO - Return code: 0 09:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:36 INFO - https://queue.taskcluster.net/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:11:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:11:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:11:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:11:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:11:38 INFO - Downloaded 14403333 bytes. 09:11:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:11:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:11:38 INFO - Return code: 0 09:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:38 INFO - https://queue.taskcluster.net/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:11:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:11:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:11:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:11:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:11:39 INFO - Downloaded 60434629 bytes. 09:11:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:11:39 INFO - mkdir: /builds/slave/test/properties 09:11:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:11:39 INFO - Writing to file /builds/slave/test/properties/build_url 09:11:39 INFO - Contents: 09:11:39 INFO - build_url:https://queue.taskcluster.net/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:11:40 INFO - Running post-action listener: _resource_record_post_action 09:11:40 INFO - Running post-action listener: set_extra_try_arguments 09:11:40 INFO - ##### 09:11:40 INFO - ##### Finished download-and-extract step (success) 09:11:40 INFO - ##### 09:11:40 INFO - ##### 09:11:40 INFO - ##### Running populate-webroot step. 09:11:40 INFO - ##### 09:11:40 INFO - Running pre-action listener: _resource_record_pre_action 09:11:40 INFO - Running main action method: populate_webroot 09:11:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:11:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:11:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:11:40 INFO - '--tppagecycles', 09:11:40 INFO - '7'], 09:11:40 INFO - 'tests': ['tsvgm']}}, 09:11:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:11:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:11:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:11:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:11:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:11:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:11:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:40 INFO - 'talos_options': ['--disable-e10s'], 09:11:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:11:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:11:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:40 INFO - 'talos_options': ['--disable-e10s'], 09:11:40 INFO - 'tests': ['damp', 'tps']}, 09:11:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:40 INFO - 'tests': ['damp', 'tps']}, 09:11:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:11:40 INFO - 'tests': ['dromaeo_dom']}, 09:11:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:11:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:11:40 INFO - 'tests': ['basic_compositor_video']}, 09:11:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:11:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:11:40 INFO - 'tests': ['a11yr', 09:11:40 INFO - 'ts_paint', 09:11:40 INFO - 'tpaint', 09:11:40 INFO - 'sessionrestore', 09:11:40 INFO - 'sessionrestore_no_auto_restore', 09:11:40 INFO - 'tabpaint']}, 09:11:40 INFO - 'other-e10s': {'tests': ['a11yr', 09:11:40 INFO - 'ts_paint', 09:11:40 INFO - 'tpaint', 09:11:40 INFO - 'sessionrestore', 09:11:40 INFO - 'sessionrestore_no_auto_restore', 09:11:40 INFO - 'tabpaint']}, 09:11:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:11:40 INFO - 'ts_paint', 09:11:40 INFO - 'tpaint', 09:11:40 INFO - 'sessionrestore', 09:11:40 INFO - 'sessionrestore_no_auto_restore', 09:11:40 INFO - 'tabpaint']}, 09:11:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:11:40 INFO - 'ts_paint', 09:11:40 INFO - 'tpaint', 09:11:40 INFO - 'sessionrestore', 09:11:40 INFO - 'sessionrestore_no_auto_restore', 09:11:40 INFO - 'tabpaint']}, 09:11:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:11:40 INFO - 'tests': ['a11yr', 09:11:40 INFO - 'ts_paint', 09:11:40 INFO - 'tpaint', 09:11:40 INFO - 'sessionrestore', 09:11:40 INFO - 'sessionrestore_no_auto_restore', 09:11:40 INFO - 'tabpaint']}, 09:11:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:11:40 INFO - 'tests': ['a11yr', 09:11:40 INFO - 'ts_paint', 09:11:40 INFO - 'tpaint', 09:11:40 INFO - 'sessionrestore', 09:11:40 INFO - 'sessionrestore_no_auto_restore', 09:11:40 INFO - 'tabpaint']}, 09:11:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:11:40 INFO - 'tests': ['tsvgx', 09:11:40 INFO - 'tsvgr_opacity', 09:11:40 INFO - 'tart', 09:11:40 INFO - 'tscrollx', 09:11:40 INFO - 'cart']}, 09:11:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:11:40 INFO - 'tsvgr_opacity', 09:11:40 INFO - 'tart', 09:11:40 INFO - 'tscrollx', 09:11:40 INFO - 'cart']}, 09:11:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:40 INFO - 'talos_options': ['--disable-e10s'], 09:11:40 INFO - 'tests': ['tp5o']}, 09:11:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:40 INFO - 'tests': ['tp5o']}, 09:11:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:40 INFO - 'talos_options': ['--disable-e10s', 09:11:40 INFO - '--xperf_path', 09:11:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:11:40 INFO - 'tests': ['tp5n']}, 09:11:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:40 INFO - 'talos_options': ['--xperf_path', 09:11:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:11:40 INFO - 'tests': ['tp5n']}}, 09:11:40 INFO - 'talos.zip': {'path': '', 09:11:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:11:40 INFO - Running post-action listener: _resource_record_post_action 09:11:40 INFO - ##### 09:11:40 INFO - ##### Finished populate-webroot step (success) 09:11:40 INFO - ##### 09:11:40 INFO - ##### 09:11:40 INFO - ##### Running create-virtualenv step. 09:11:40 INFO - ##### 09:11:40 INFO - Running pre-action listener: _resource_record_pre_action 09:11:40 INFO - Running main action method: create_virtualenv 09:11:40 INFO - Creating virtualenv /builds/slave/test/build/venv 09:11:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:11:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:11:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:11:40 INFO - Using real prefix '/usr' 09:11:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:11:41 INFO - Installing distribute.............................................................................................................................................................................................done. 09:11:43 INFO - Installing pip.................done. 09:11:43 INFO - Return code: 0 09:11:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:43 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 0x1258030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1519180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15173b0>, '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 0x15182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1518740>, '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': '6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:11:43 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 09:11:43 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 09:11:43 INFO - Using env: {'DISPLAY': ':0', 09:11:43 INFO - 'HOME': '/home/cltbld', 09:11:43 INFO - 'LANG': 'en_US.UTF-8', 09:11:43 INFO - 'LANGUAGE': 'en_US:en', 09:11:43 INFO - 'LOGNAME': 'cltbld', 09:11:43 INFO - 'MAIL': '/var/mail/cltbld', 09:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:43 INFO - 'MOZ_NO_REMOTE': '1', 09:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:43 INFO - 'NO_EM_RESTART': '1', 09:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:43 INFO - 'PWD': '/builds/slave/test', 09:11:43 INFO - 'SHELL': '/bin/bash', 09:11:43 INFO - 'SHLVL': '1', 09:11:43 INFO - 'TERM': 'linux', 09:11:43 INFO - 'TMOUT': '86400', 09:11:43 INFO - 'USER': 'cltbld', 09:11:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921', 09:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:43 INFO - '_': '/tools/buildbot/bin/python'} 09:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:11:43 INFO - Cleaning up... 09:11:43 INFO - Return code: 0 09:11:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:43 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 0x1258030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1519180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15173b0>, '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 0x15182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1518740>, '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': '6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:11:43 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 09:11:43 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 09:11:43 INFO - Using env: {'DISPLAY': ':0', 09:11:43 INFO - 'HOME': '/home/cltbld', 09:11:43 INFO - 'LANG': 'en_US.UTF-8', 09:11:43 INFO - 'LANGUAGE': 'en_US:en', 09:11:43 INFO - 'LOGNAME': 'cltbld', 09:11:43 INFO - 'MAIL': '/var/mail/cltbld', 09:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:43 INFO - 'MOZ_NO_REMOTE': '1', 09:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:43 INFO - 'NO_EM_RESTART': '1', 09:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:43 INFO - 'PWD': '/builds/slave/test', 09:11:43 INFO - 'SHELL': '/bin/bash', 09:11:43 INFO - 'SHLVL': '1', 09:11:43 INFO - 'TERM': 'linux', 09:11:43 INFO - 'TMOUT': '86400', 09:11:43 INFO - 'USER': 'cltbld', 09:11:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921', 09:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:43 INFO - '_': '/tools/buildbot/bin/python'} 09:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:43 INFO - Downloading/unpacking psutil>=3.1.1 09:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:43 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 09:11:43 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 09:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:11:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:11:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:11:45 INFO - Installing collected packages: psutil 09:11:45 INFO - Running setup.py install for psutil 09:11:45 INFO - building 'psutil._psutil_linux' extension 09:11:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:11:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:11:45 INFO - building 'psutil._psutil_posix' extension 09:11:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:11:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:11:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:11:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:11:45 INFO - Successfully installed psutil 09:11:45 INFO - Cleaning up... 09:11:46 INFO - Return code: 0 09:11:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:11: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:46 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 0x1258030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1519180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15173b0>, '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 0x15182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1518740>, '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': '6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:11:46 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 09:11:46 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 09:11:46 INFO - Using env: {'DISPLAY': ':0', 09:11:46 INFO - 'HOME': '/home/cltbld', 09:11:46 INFO - 'LANG': 'en_US.UTF-8', 09:11:46 INFO - 'LANGUAGE': 'en_US:en', 09:11:46 INFO - 'LOGNAME': 'cltbld', 09:11:46 INFO - 'MAIL': '/var/mail/cltbld', 09:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:46 INFO - 'MOZ_NO_REMOTE': '1', 09:11:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:46 INFO - 'NO_EM_RESTART': '1', 09:11:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:46 INFO - 'PWD': '/builds/slave/test', 09:11:46 INFO - 'SHELL': '/bin/bash', 09:11:46 INFO - 'SHLVL': '1', 09:11:46 INFO - 'TERM': 'linux', 09:11:46 INFO - 'TMOUT': '86400', 09:11:46 INFO - 'USER': 'cltbld', 09:11:46 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921', 09:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:46 INFO - '_': '/tools/buildbot/bin/python'} 09:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:46 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 09:11:46 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 09:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:11:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:11:48 INFO - Installing collected packages: mozsystemmonitor 09:11:48 INFO - Running setup.py install for mozsystemmonitor 09:11:48 INFO - Successfully installed mozsystemmonitor 09:11:48 INFO - Cleaning up... 09:11:48 INFO - Return code: 0 09:11:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:48 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 0x1258030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1519180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15173b0>, '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 0x15182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1518740>, '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': '6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:11:48 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 09:11:48 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 09:11:48 INFO - Using env: {'DISPLAY': ':0', 09:11:48 INFO - 'HOME': '/home/cltbld', 09:11:48 INFO - 'LANG': 'en_US.UTF-8', 09:11:48 INFO - 'LANGUAGE': 'en_US:en', 09:11:48 INFO - 'LOGNAME': 'cltbld', 09:11:48 INFO - 'MAIL': '/var/mail/cltbld', 09:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:48 INFO - 'MOZ_NO_REMOTE': '1', 09:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:48 INFO - 'NO_EM_RESTART': '1', 09:11:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:48 INFO - 'PWD': '/builds/slave/test', 09:11:48 INFO - 'SHELL': '/bin/bash', 09:11:48 INFO - 'SHLVL': '1', 09:11:48 INFO - 'TERM': 'linux', 09:11:48 INFO - 'TMOUT': '86400', 09:11:48 INFO - 'USER': 'cltbld', 09:11:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921', 09:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:48 INFO - '_': '/tools/buildbot/bin/python'} 09:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:48 INFO - Downloading/unpacking jsonschema==2.5.1 09:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:48 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 09:11:48 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 09:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:11:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:50 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 09:11:50 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 09:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:50 INFO - Downloading functools32-3.2.3-2.tar.gz 09:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:11:50 INFO - warning: no files found matching '*.txt' 09:11:50 INFO - no previously-included directories found matching 'build' 09:11:50 INFO - no previously-included directories found matching 'dist' 09:11:50 INFO - no previously-included directories found matching '.git*' 09:11:50 INFO - Installing collected packages: jsonschema, functools32 09:11:50 INFO - Running setup.py install for functools32 09:11:50 INFO - warning: no files found matching '*.txt' 09:11:50 INFO - no previously-included directories found matching 'build' 09:11:50 INFO - no previously-included directories found matching 'dist' 09:11:50 INFO - no previously-included directories found matching '.git*' 09:11:50 INFO - Successfully installed jsonschema functools32 09:11:50 INFO - Cleaning up... 09:11:50 INFO - Return code: 0 09:11:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:11: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11: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', '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 0x1258030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1519180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15173b0>, '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 0x15182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1518740>, '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': '6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:11: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:11: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 blobuploader==1.2.4 09:11:50 INFO - Using env: {'DISPLAY': ':0', 09:11:50 INFO - 'HOME': '/home/cltbld', 09:11:50 INFO - 'LANG': 'en_US.UTF-8', 09:11:50 INFO - 'LANGUAGE': 'en_US:en', 09:11:50 INFO - 'LOGNAME': 'cltbld', 09:11:50 INFO - 'MAIL': '/var/mail/cltbld', 09:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:50 INFO - 'MOZ_NO_REMOTE': '1', 09:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:50 INFO - 'NO_EM_RESTART': '1', 09:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:50 INFO - 'PWD': '/builds/slave/test', 09:11:50 INFO - 'SHELL': '/bin/bash', 09:11:50 INFO - 'SHLVL': '1', 09:11:50 INFO - 'TERM': 'linux', 09:11:50 INFO - 'TMOUT': '86400', 09:11:50 INFO - 'USER': 'cltbld', 09:11:50 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921', 09:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:50 INFO - '_': '/tools/buildbot/bin/python'} 09:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:51 INFO - Downloading/unpacking blobuploader==1.2.4 09:11: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 09:11: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 09:11: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 09:11: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 09:11: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 09:11: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 09:11:52 INFO - Downloading blobuploader-1.2.4.tar.gz 09:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:11:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:53 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 09:11:53 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 09:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:11:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:53 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 09:11:53 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 09:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:53 INFO - Downloading docopt-0.6.1.tar.gz 09:11:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:11:53 INFO - Installing collected packages: blobuploader, requests, docopt 09:11:53 INFO - Running setup.py install for blobuploader 09:11:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:11:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:11:53 INFO - Running setup.py install for requests 09:11:54 INFO - Running setup.py install for docopt 09:11:54 INFO - Successfully installed blobuploader requests docopt 09:11:54 INFO - Cleaning up... 09:11:54 INFO - Return code: 0 09:11:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:54 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 0x1258030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1519180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15173b0>, '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 0x15182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1518740>, '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': '6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:11:54 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 09:11:54 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 09:11:54 INFO - Using env: {'DISPLAY': ':0', 09:11:54 INFO - 'HOME': '/home/cltbld', 09:11:54 INFO - 'LANG': 'en_US.UTF-8', 09:11:54 INFO - 'LANGUAGE': 'en_US:en', 09:11:54 INFO - 'LOGNAME': 'cltbld', 09:11:54 INFO - 'MAIL': '/var/mail/cltbld', 09:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:54 INFO - 'MOZ_NO_REMOTE': '1', 09:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:54 INFO - 'NO_EM_RESTART': '1', 09:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:54 INFO - 'PWD': '/builds/slave/test', 09:11:54 INFO - 'SHELL': '/bin/bash', 09:11:54 INFO - 'SHLVL': '1', 09:11:54 INFO - 'TERM': 'linux', 09:11:54 INFO - 'TMOUT': '86400', 09:11:54 INFO - 'USER': 'cltbld', 09:11:54 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921', 09:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:54 INFO - '_': '/tools/buildbot/bin/python'} 09:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:11:54 INFO - Running setup.py (path:/tmp/pip-cf5PFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:11:54 INFO - Running setup.py (path:/tmp/pip-T4fmiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:11:54 INFO - Running setup.py (path:/tmp/pip-gHMmdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:11:54 INFO - Running setup.py (path:/tmp/pip-n2lDjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:11:54 INFO - Running setup.py (path:/tmp/pip-u7d1UN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:11:54 INFO - Running setup.py (path:/tmp/pip-1u0AeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:11:55 INFO - Running setup.py (path:/tmp/pip-m1UZx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:11:55 INFO - Running setup.py (path:/tmp/pip-n6Xqpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:11:55 INFO - Running setup.py (path:/tmp/pip-wI7pvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:11:55 INFO - Running setup.py (path:/tmp/pip-jSft6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:11:55 INFO - Running setup.py (path:/tmp/pip-0lYCmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:11:55 INFO - Running setup.py (path:/tmp/pip-LveABg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:11:55 INFO - Running setup.py (path:/tmp/pip-Z_sUAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:11:55 INFO - Running setup.py (path:/tmp/pip-BT0mhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:55 INFO - Running setup.py (path:/tmp/pip-WOXx58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:11:55 INFO - Running setup.py (path:/tmp/pip-Nv0Q2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:11:55 INFO - Running setup.py (path:/tmp/pip-Ktm8BU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:11:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:11:55 INFO - Running setup.py install for manifestparser 09:11:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:11:55 INFO - Running setup.py install for mozcrash 09:11:56 INFO - Running setup.py install for mozdebug 09:11:56 INFO - Running setup.py install for mozdevice 09:11:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:11:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:11:56 INFO - Running setup.py install for mozfile 09:11:56 INFO - Running setup.py install for mozhttpd 09:11:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:11:56 INFO - Running setup.py install for mozinfo 09:11:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:11:56 INFO - Running setup.py install for mozInstall 09:11:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:11:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:11:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:11:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:11:56 INFO - Running setup.py install for mozleak 09:11:56 INFO - Running setup.py install for mozlog 09:11:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:11:56 INFO - Running setup.py install for moznetwork 09:11:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:11:56 INFO - Running setup.py install for mozprocess 09:11:57 INFO - Running setup.py install for mozprofile 09:11:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:11:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:11:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:11:57 INFO - Running setup.py install for mozrunner 09:11:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:11:57 INFO - Running setup.py install for mozscreenshot 09:11:57 INFO - Running setup.py install for moztest 09:11:57 INFO - Running setup.py install for mozversion 09:11:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:11:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:11:57 INFO - Cleaning up... 09:11:57 INFO - Return code: 0 09:11:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:57 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 0x1258030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1519180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15173b0>, '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 0x15182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1518740>, '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': '6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:11:57 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 09:11:57 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 09:11:57 INFO - Using env: {'DISPLAY': ':0', 09:11:57 INFO - 'HOME': '/home/cltbld', 09:11:57 INFO - 'LANG': 'en_US.UTF-8', 09:11:57 INFO - 'LANGUAGE': 'en_US:en', 09:11:57 INFO - 'LOGNAME': 'cltbld', 09:11:57 INFO - 'MAIL': '/var/mail/cltbld', 09:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:57 INFO - 'MOZ_NO_REMOTE': '1', 09:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:57 INFO - 'NO_EM_RESTART': '1', 09:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:57 INFO - 'PWD': '/builds/slave/test', 09:11:57 INFO - 'SHELL': '/bin/bash', 09:11:57 INFO - 'SHLVL': '1', 09:11:57 INFO - 'TERM': 'linux', 09:11:57 INFO - 'TMOUT': '86400', 09:11:57 INFO - 'USER': 'cltbld', 09:11:57 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921', 09:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:57 INFO - '_': '/tools/buildbot/bin/python'} 09:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:11:57 INFO - Running setup.py (path:/tmp/pip-BPw22a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:11:57 INFO - Running setup.py (path:/tmp/pip-LjRUlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:11:57 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)) 09:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:11:57 INFO - Running setup.py (path:/tmp/pip-dxZUyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:11:58 INFO - Running setup.py (path:/tmp/pip-41drf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:11:58 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)) 09:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:11:58 INFO - Running setup.py (path:/tmp/pip-JvF7KD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:11:58 INFO - Running setup.py (path:/tmp/pip-g0M4pO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:11:58 INFO - Running setup.py (path:/tmp/pip-w6GHcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:11:58 INFO - Running setup.py (path:/tmp/pip-30utTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:11:58 INFO - Running setup.py (path:/tmp/pip-w3eWqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:11:58 INFO - Running setup.py (path:/tmp/pip-VGcSrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:11:58 INFO - Running setup.py (path:/tmp/pip-6Hacgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:11:58 INFO - Running setup.py (path:/tmp/pip-PVVz6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:11:58 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)) 09:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:11:58 INFO - Running setup.py (path:/tmp/pip-heKg7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:11:58 INFO - Running setup.py (path:/tmp/pip-V6qWy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:11:58 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)) 09:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:58 INFO - Running setup.py (path:/tmp/pip-53hN7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:11:59 INFO - Running setup.py (path:/tmp/pip-134HGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:11:59 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)) 09:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:11:59 INFO - Running setup.py (path:/tmp/pip-XHKTIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:11:59 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)) 09:11:59 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)) 09:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:11:59 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)) 09:11:59 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)) 09:11:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:11: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 09:11: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 09:11: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 09:11: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 09:11: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 09:11: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 09:12:01 INFO - Downloading blessings-1.6.tar.gz 09:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:12:01 INFO - Installing collected packages: blessings 09:12:01 INFO - Running setup.py install for blessings 09:12:01 INFO - Successfully installed blessings 09:12:01 INFO - Cleaning up... 09:12:01 INFO - Return code: 0 09:12:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:12:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:12:01 INFO - Reading from file tmpfile_stdout 09:12:01 INFO - Current package versions: 09:12:01 INFO - argparse == 1.2.1 09:12:01 INFO - blessings == 1.6 09:12:01 INFO - blobuploader == 1.2.4 09:12:01 INFO - docopt == 0.6.1 09:12:01 INFO - functools32 == 3.2.3-2 09:12:01 INFO - jsonschema == 2.5.1 09:12:01 INFO - manifestparser == 1.1 09:12:01 INFO - mozInstall == 1.12 09:12:01 INFO - mozcrash == 0.17 09:12:01 INFO - mozdebug == 0.1 09:12:01 INFO - mozdevice == 0.48 09:12:01 INFO - mozfile == 1.2 09:12:01 INFO - mozhttpd == 0.7 09:12:01 INFO - mozinfo == 0.9 09:12:01 INFO - mozleak == 0.1 09:12:01 INFO - mozlog == 3.2 09:12:01 INFO - moznetwork == 0.27 09:12:01 INFO - mozprocess == 0.23 09:12:01 INFO - mozprofile == 0.28 09:12:01 INFO - mozrunner == 6.12 09:12:01 INFO - mozscreenshot == 0.1 09:12:01 INFO - mozsystemmonitor == 0.3 09:12:01 INFO - moztest == 0.7 09:12:01 INFO - mozversion == 1.4 09:12:01 INFO - psutil == 3.1.1 09:12:01 INFO - requests == 1.2.3 09:12:01 INFO - wsgiref == 0.1.2 09:12:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:01 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 0x1258030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1519180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15173b0>, '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 0x15182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1518740>, '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': '6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12:01 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 09:12:01 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 09:12:01 INFO - Using env: {'DISPLAY': ':0', 09:12:01 INFO - 'HOME': '/home/cltbld', 09:12:01 INFO - 'LANG': 'en_US.UTF-8', 09:12:01 INFO - 'LANGUAGE': 'en_US:en', 09:12:01 INFO - 'LOGNAME': 'cltbld', 09:12:01 INFO - 'MAIL': '/var/mail/cltbld', 09:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:01 INFO - 'MOZ_NO_REMOTE': '1', 09:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:01 INFO - 'NO_EM_RESTART': '1', 09:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:01 INFO - 'PWD': '/builds/slave/test', 09:12:01 INFO - 'SHELL': '/bin/bash', 09:12:01 INFO - 'SHLVL': '1', 09:12:01 INFO - 'TERM': 'linux', 09:12:01 INFO - 'TMOUT': '86400', 09:12:01 INFO - 'USER': 'cltbld', 09:12:01 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921', 09:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:01 INFO - '_': '/tools/buildbot/bin/python'} 09:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:12:01 INFO - Cleaning up... 09:12:01 INFO - Return code: 0 09:12:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1258030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1519180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15173b0>, '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 0x15182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1518740>, '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': '6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12:01 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 09:12:01 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 09:12:01 INFO - Using env: {'DISPLAY': ':0', 09:12:01 INFO - 'HOME': '/home/cltbld', 09:12:01 INFO - 'LANG': 'en_US.UTF-8', 09:12:01 INFO - 'LANGUAGE': 'en_US:en', 09:12:01 INFO - 'LOGNAME': 'cltbld', 09:12:01 INFO - 'MAIL': '/var/mail/cltbld', 09:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:01 INFO - 'MOZ_NO_REMOTE': '1', 09:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:01 INFO - 'NO_EM_RESTART': '1', 09:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:01 INFO - 'PWD': '/builds/slave/test', 09:12:01 INFO - 'SHELL': '/bin/bash', 09:12:01 INFO - 'SHLVL': '1', 09:12:01 INFO - 'TERM': 'linux', 09:12:01 INFO - 'TMOUT': '86400', 09:12:01 INFO - 'USER': 'cltbld', 09:12:01 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921', 09:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:01 INFO - '_': '/tools/buildbot/bin/python'} 09:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:12:01 INFO - Cleaning up... 09:12:01 INFO - Return code: 0 09:12:01 INFO - Running post-action listener: _resource_record_post_action 09:12:01 INFO - Running post-action listener: _start_resource_monitoring 09:12:02 INFO - Starting resource monitoring. 09:12:02 INFO - ##### 09:12:02 INFO - ##### Finished create-virtualenv step (success) 09:12:02 INFO - ##### 09:12:02 INFO - ##### 09:12:02 INFO - ##### Running install step. 09:12:02 INFO - ##### 09:12:02 INFO - Running pre-action listener: _resource_record_pre_action 09:12:02 INFO - Running main action method: install 09:12:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:12:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:12:02 INFO - Reading from file tmpfile_stdout 09:12:02 INFO - Detecting whether we're running mozinstall >=1.0... 09:12:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:12:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:12:02 INFO - Reading from file tmpfile_stdout 09:12:02 INFO - Output received: 09:12:02 INFO - Usage: mozinstall [options] installer 09:12:02 INFO - Options: 09:12:02 INFO - -h, --help show this help message and exit 09:12:02 INFO - -d DEST, --destination=DEST 09:12:02 INFO - Directory to install application into. [default: 09:12:02 INFO - "/builds/slave/test"] 09:12:02 INFO - --app=APP Application being installed. [default: firefox] 09:12:02 INFO - mkdir: /builds/slave/test/build/application 09:12:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:12:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:12:19 INFO - Reading from file tmpfile_stdout 09:12:19 INFO - Output received: 09:12:19 INFO - /builds/slave/test/build/application/firefox/firefox 09:12:19 INFO - Running post-action listener: _resource_record_post_action 09:12:19 INFO - ##### 09:12:19 INFO - ##### Finished install step (success) 09:12:19 INFO - ##### 09:12:19 INFO - ##### 09:12:19 INFO - ##### Running run-tests step. 09:12:19 INFO - ##### 09:12:19 INFO - Running pre-action listener: _resource_record_pre_action 09:12:19 INFO - Running main action method: run_tests 09:12:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:12:19 INFO - Python 2.7.3 09:12:19 INFO - Return code: 0 09:12:19 INFO - grabbing minidump binary from tooltool 09:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:19 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 0x15173b0>, '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 0x15182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1518740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:12:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:12:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:12:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:12:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:12:19 INFO - Return code: 0 09:12:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:12:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:12:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:12:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:12:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:12:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:12:19 INFO - Using env: {'DISPLAY': ':0', 09:12:19 INFO - 'HOME': '/home/cltbld', 09:12:19 INFO - 'LANG': 'en_US.UTF-8', 09:12:19 INFO - 'LANGUAGE': 'en_US:en', 09:12:19 INFO - 'LOGNAME': 'cltbld', 09:12:19 INFO - 'MAIL': '/var/mail/cltbld', 09:12:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:12:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:19 INFO - 'MOZ_NO_REMOTE': '1', 09:12:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:19 INFO - 'NO_EM_RESTART': '1', 09:12:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:19 INFO - 'PWD': '/builds/slave/test', 09:12:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:12:19 INFO - 'SHELL': '/bin/bash', 09:12:19 INFO - 'SHLVL': '1', 09:12:19 INFO - 'TERM': 'linux', 09:12:19 INFO - 'TMOUT': '86400', 09:12:19 INFO - 'USER': 'cltbld', 09:12:19 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921', 09:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:19 INFO - '_': '/tools/buildbot/bin/python'} 09:12:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:12:19 INFO - mozversion application_buildid: 20160708063001 09:12:19 INFO - mozversion application_changeset: a74a1865eb97f56ca13947e1f62790ab0454c372 09:12:19 INFO - mozversion application_display_name: Nightly 09:12:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:12:19 INFO - mozversion application_name: Firefox 09:12:19 INFO - mozversion application_remotingname: firefox 09:12:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:12:19 INFO - mozversion application_vendor: Mozilla 09:12:19 INFO - mozversion application_version: 50.0a1 09:12:19 INFO - mozversion platform_buildid: 20160708063001 09:12:19 INFO - mozversion platform_changeset: a74a1865eb97f56ca13947e1f62790ab0454c372 09:12:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:12:19 INFO - mozversion platform_version: 50.0a1 09:12:19 INFO - using testdate: 1467994339 09:12:19 INFO - actual date: 1467994339 09:12:19 INFO - starting webserver on 'localhost:47956' 09:12:19 INFO - SUITE-START | Running 2 tests 09:12:19 INFO - TEST-START | dromaeo_css 09:12:19 INFO - operating with platform_type : linux_ 09:12:19 INFO - Initialising browser for dromaeo_css test... 09:12:19 INFO - TEST-INFO | started process 12790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHCrsI0/profile http://localhost:47956/getInfo.html) 09:12:23 INFO - PROCESS | 12790 | __metrics Screen width/height:1600/1200 09:12:23 INFO - PROCESS | 12790 | colorDepth:24 09:12:23 INFO - PROCESS | 12790 | Browser inner width/height: 1024/697 09:12:23 INFO - PROCESS | 12790 | __metrics 09:12:24 INFO - PROCESS | 12790 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:12:25 INFO - TEST-INFO | 12790: exit 0 09:12:25 INFO - Browser initialized. 09:12:25 INFO - Running cycle 1/1 for dromaeo_css test... 09:12:25 INFO - TEST-INFO | started process 12871 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHCrsI0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:12:36 INFO - PROCESS | 12871 | RSS: Main: 156893184 09:12:36 INFO - PROCESS | 12871 | 09:13:28 INFO - PROCESS | 12871 | 1467994408436 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] 09:15:36 INFO - PROCESS | 12871 | Cycle 1(1): loaded http://localhost:47956/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47956/tests/dromaeo/cssquery-ext.html) 09:15:37 INFO - PROCESS | 12871 | RSS: Main: 252440576 09:15:37 INFO - PROCESS | 12871 | 09:18:39 INFO - PROCESS | 12871 | Cycle 1(1): loaded http://localhost:47956/tests/dromaeo/cssquery-ext.html (next: http://localhost:47956/tests/dromaeo/cssquery-jquery.html) 09:18:40 INFO - PROCESS | 12871 | RSS: Main: 248692736 09:18:40 INFO - PROCESS | 12871 | 09:21:42 INFO - PROCESS | 12871 | Cycle 1(1): loaded http://localhost:47956/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47956/tests/dromaeo/cssquery-mootools.html) 09:21:42 INFO - PROCESS | 12871 | RSS: Main: 244682752 09:21:42 INFO - PROCESS | 12871 | 09:24:44 INFO - PROCESS | 12871 | Cycle 1(1): loaded http://localhost:47956/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47956/tests/dromaeo/cssquery-prototype.html) 09:24:45 INFO - PROCESS | 12871 | RSS: Main: 232726528 09:24:45 INFO - PROCESS | 12871 | 09:27:48 INFO - PROCESS | 12871 | Cycle 1(1): loaded http://localhost:47956/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47956/tests/dromaeo/cssquery-yui.html) 09:27:48 INFO - PROCESS | 12871 | RSS: Main: 223264768 09:27:48 INFO - PROCESS | 12871 | 09:30:51 INFO - PROCESS | 12871 | Cycle 1(1): loaded http://localhost:47956/tests/dromaeo/cssquery-yui.html (next: http://localhost:47956/tests/dromaeo/cssquery-dojo.html) 09:30:51 INFO - PROCESS | 12871 | RSS: Main: 275087360 09:30:51 INFO - PROCESS | 12871 | 09:30:51 INFO - PROCESS | 12871 | __start_tp_report 09:30:51 INFO - PROCESS | 12871 | _x_x_mozilla_page_load 09:30:51 INFO - PROCESS | 12871 | _x_x_mozilla_page_load_details 09:30:51 INFO - PROCESS | 12871 | |i|pagename|runs| 09:30:51 INFO - PROCESS | 12871 | |0;dojo.html;3020.1090678249916;3044.8020878642874;3054.6334439867214;3072.0323098224044;3083.3679095785365;5238;5272.420033796289;5297;5382.192671099337;5395.244665746799;5213.3743950725875;5279;5280.841574752763;5302.814401495948;5341.385740639827;4771.045790841837;4795.808167673289;4824.276358546211;4833.419989601252;4946.109700253953;4874.65877388583;4887.340209071783;4915.066137433894;4932.728699921503;4954.900901981958;4757.666963312552;4778.904421911577;4781;4814.085323788504;4826.927596086061;4767.427908650984;4803.519648035203;4871.318015477836;4874.512548745132;4916.1888288432365;4740.1230772307235;4740.834070807539;4763.49983251757;4794.472608013116;4818.734969576672;5097.592192624618;5182.041322355376;5194.039102766001;5252.422233554306;5258.947410525884;5558.471945165203;5565.693886836222;5591.3569939457075;5592.804251851207;5604.299462567179;5522.585806064521;5571.498565129158;5672.546196304327;5674.886502269973;5678.914816277759;5240.213967904845;5281.577473802086;5304.151335786294;5319.7340132993195;5321.015612111772;5788.855278617984;5793.797217097465;5804.854878628068;5805.216295800097;5822.854428639318;5284.339457567804;5464.754086066137;5465.152901300305;5552.167174923794;5558;5676.829695109153;5677.3471050829685;5685.459881311352;5689.118186681071;5695.800646977336;5608.9439105609235;5612.5229355504425;5614.29821272341;5620.128880023522;5658.151277308354;5509.752061157257;5562.471565201299;5620.409856965041;5623.184638227516;5625.971870140623;4355.869323920288;4358.585934336233;4361.869143925687;4362.585554372329;4392.912141757147;3835.8465661373234;3864.516935383077;3875.5930627284292;3892.552356479041;3896.2207558488417;5243.449437809051;5252.29094072303;5294.338207724035;5304.416514183436;5308.0710875596615;5589.692566908778;5592.608517403743;5601.243832082698;5609.943900561024;5659.603827732101;5277.313949186581;5301.257823904656;5313.57491400687;5321.281626980385;5376.516113549799;4787.808487660454;4870.659053866196;4910.042541704333;4921.138800709861;4947.5794557462295;5901.409859014064;5902.173695682608;5904.527637788967;5911.024680927599;5918.082697181943;5704.458076482728;5722.914156287576;5723.284589426322;5725.885482290414;5728.198052272768;5628.437156284503;5766.048601980626;5824.9708751457665;5826.796062137805;5871.1486834407915;5504.256925315031;5551.084071128219;5554.555635549065;5558.194061860927;5562.471565201299;5520.7515661796115;5661.773529058792;5676.744546495335;5677.602567820378;5681.0910254359105;5451.536619387396;5452.045891968969;5460.426655201306;5475.151351540518;5478.479544443271;5467.835964921059;5468.7539060741565;5500.559955203494;5522.088855338824;5530.6128570999645;5324.4675532446445;5423.050966080999;5435.402105768441;5443.265159203457;5491.780328786804;5571.415001424792;5620.859478512906;5621.887562248814;5668.121441176624;5668.971655141698;5499.450054994469;5501.284832971848;5501.312335958005;5502.889942201214;5504.779808807602 09:30:51 INFO - PROCESS | 12871 | |1;ext.html;572.831014850619;584.8800995795863;605.9394060593941;614.7633161232924;621.7668374359612;30491.695083049162;41875.790621046894;42363.36454953178;42433.78783106084;42496.57503424965;45035.77482112585;45184.322235166495;45257;45335.77332113343;45441.31838022432;7815.2966233039015;8982.955085224565;9173.495457749854;9178.036306187854;10677.519511621957;10545.683629491128;10951.233413661046;10964.396958167297;10985;10989.395583242918;11066;11104.833427498594;11108.833367499494;11111.72220694481;11119.1660625453;10992.28550144238;11025.503852326665;11038.11695064393;11043.061339786127;11043.3926134063;10699.786004279871;10779.730506737316;10779.892201077968;10781.299215550964;10785.78428431427;42674.14651706949;42786.14427711428;43164.784176078916;43209;43241.35137972933;3605.855765769366;3690.5755838078426;3739.5325584301963;3831.9042023949346;4113.547509773923;33377.83311083429;33635.15912102193;33957.6604233957;33990.32019359599;35015.824920875486;4245.405643209953;4247.193033323659;4278.080212754242;4290.163418133465;4327.3725309830215;252518;252981.73509132522;253388;254094;254569;30786.230344241572;57765;58199.4180058194;58473.70763146157;58554.414455855745;36389.81805090958;36494.45258321127;36561.45157822635;36597.451038234445;36605;14640;14720.852791471949;14732.337044833008;14734.115953042852;14749.262536873113;11041.613543525938;12408.875911240772;12705.872941270654;12878.356082195853;13182.143160694524;8281.37889658278;8392.79018024542;8396;8442.409031367868;8459.957700211582;2918.8832446702318;2970.613820203403;3196.376706542202;3204.1829333519804;3272.9836350818096;1008.9394636321845;1047.6909311753052;1060.9363438193734;1080.1304949515559;1098.280626189847;33197.3360532788;33545;33696.83151584226;33756.324873502395;33851.153721156676;1122.2256642916361;1142.971425714347;1153.2042890405594;1154.440096553171;1202.1524824998355;17272.65454690899;17348.30606775715;17537.56156096108;17578.824211757717;17589.824101759074;596495;599854;600082;601032;604204;56225;56717.71641141851;56753.43246567564;56787.43212567904;56847.71576142093;1129.209553312668;1313.6978494946216;1357.0704067713648;1358.4634069542476;1382.4055656067787;32482.35035299328;33786.155346116546;34232.31535369329;34492.82753586216;34537.48193777045;49136.50863491462;49829;49914.750426247636;49940;49970.25044624261;310764;316484;316916;317743;318104;23393.76606233984;24031.639525406783;25852.61221081648;26512.734872651028;26864;46922.53077469182;46974.76512617415;47509.287360688926;47564.28653570268;48182;38554;38646.6135338643;38713.61286387213;38742.80628596839;38750.6124938747;38365.424518632804;38524.42213366858;38654.42018369783;38666.80666596649;39514.2097158061;39981.80009099936;40803.7959810199;40964;40975.795121025396;41131.7943410281;35261.294774104885;36197;37233.25533489369;37486.43770343393;37552.81223593865;28284.85857570699;28301.71698282991;28381.85809071024;28436.289092772848;28532.85733571319 09:30:51 INFO - PROCESS | 12871 | |2;jquery.html;390.82412914188586;394.5364197068446;399.8620475935801;400.96992725545584;415.8835526052706;13311.800322995163;18939.242430302787;20419.081141348637;20693.586128277446;20746;15143.318550665219;15349.232538373093;17238.741418878726;19910.701339479918;21086.89456552719;5856.707164641773;5926.674032928187;6047.304559975593;6047.606905551147;6080.604760690563;5832.154337621042;5920.88158236835;5935.643861368331;5959.70201489926;5972.611780234271;4215.620594146526;5934.495567876736;6349.809505714813;6611.107500487445;6630.93369066308;6545.280019197884;6706.765263215789;6747.291534388867;6761.188657361099;6802;5900.704964751745;5973.402659734035;6026.8493287667725;6038.879222415571;6053.69731513427;23803.285901422983;23835.404114897094;24611.753882461126;24635.137770177957;24738.876305618356;2807.1859160843333;2813.788965827551;2840.389316297006;2867.240181351943;2886.494863398918;14820.851791482162;15082.170480623561;15321.923390383088;15434.305456254495;15592;1899.67705490067;1983.5735316906935;2014.687723402875;2109.7257356543705;2151.817095546865;60894.695526522526;65586.22186273163;82798.58600707017;86563.56718216432;87575.56212218961;11230.270032448028;11349.432528373549;11637.825432618518;11684.298942063504;11690.70773230676;16086.35654573804;16186.514404567883;16254.918725406298;16285;16286.51140465788;8064.677412903536;8263.256306932404;8317.293030092389;8329.708460203863;8383.916160838435;7839.725609603636;7851.921480785233;7868.25251601097;7977.561234132062;7993;4774;4935.284383764334;4981.775820088104;5006.249062640633;5044.218146187347;1943.3878328326532;1959.970600440966;1962.4995626115249;1980.4355758608726;1987.9403617891487;966.9613215471302;970.5632465390603;988.3773222869546;1020.2195320579763;1056.413690401819;20060.696054756394;20472.79527204709;20635.17459301641;20651.69022464664;20758.58482830335;992.3053862296422;998.2912132385942;1001.4241810958728;1020.1991436722286;1060.2684147937898;10929.617463388902;11500.59747908836;11558.248713833742;11609.071274298036;11641.708957275967;445026;449999;450953;452191;454277;93546;94186;95452;95786;97561;961.9374740641836;974.0940924939732;987.170776547689;990.2968892086699;994.0109590957044;16332.918335408247;18342.90828545849;18354;18654.34709785151;18895.905520472308;42532.574674252864;43573;43767.34348984832;44240;44878.77560612176;57121;58361;60610.09084863819;61670.52459491868;61991.690041549504;8808.91191088081;9082.318826088202;9139.360244782802;9175.954120229357;9191.954040229755;13495.730085398434;14003.859961400663;14198.219097949712;14232.928835355757;14434.711305774035;12174.513019479122;12554.309512976874;12597.496100155891;12790.74418511606;12915.870841291468;8656.783580410289;11515.654530364103;11911.40442977865;12420.254784712946;12450.439730212343;12133.21134126279;12511.374431278582;12962;13038.869611303766;13176.341182940623;8734.91265087341;8837.293016558788;8884.73345799627;9072.047435019227;9417.105374989365;9479.383840050376;12703;12712.6821829455;12713.93643031779;12969.870301297244 09:30:51 INFO - PROCESS | 12871 | |3;mootools.html;1256.6795467155873;1459.2630721485652;1481.3704175725318;1616.1272912627182;1759.1995641982908;7821.804454888624;8104.716334928279;8132.552709600977;8421.19998600132;8463;8168.264856162944;8371.162883711626;8371.790705232372;8372.455790373622;8382.203690649394;1993.531520092777;2185.7595664476894;2268.897899594514;2331.5803155432013;2367.0531787285054;2300.4133945843787;2304.3087073877855;2311.456807650201;2321.2688003279;2322.4890524084676;2287.0623044551735;2287.576798292321;2325.732540757809;2326.057946531649;2329.3594261578032;1911.4552352579517;2137.775533568984;2206.6359050756605;2216.357256395643;2223.54417344444;2260.2654137405243;2261.8642881427168;2270.8069814065825;2281.783230593091;2283.1095872609694;8410.83178336436;8495.192956669107;8498.575071246474;8505.277051450634;8556.272716819078;4953.182724850395;5103.132467480537;5152.510511501401;5155.561777248939;5157.123289040872;3131.18589166816;3248.1067706380936;3312.205070782995;3318.452455344865;3322;1057.1014637558092;1081.259337353915;1093.103655002898;1106.6292791914718;1112.9871816646812;11461.770764584746;11523.42382880861;11525.596604118815;11531.481083351186;11534.134939879543;4364.454443194601;4444.844430444984;4516.029053753458;4636.86089417318;4645.256758918556;9641.084097010773;9641.37331073492;9647.421154730739;9651.951740241253;9665.565049572786;5052;5070.898582028339;5072.163093089673;5072.644914855925;5075.87310317245;4157.584241575818;4568.33759104928;4733.810647574127;4737.810487580458;4818.590419814285;3744.756590821588;3792.2605092007348;3820.675242604354;3864.343061679465;3882.7476214045996;1109.6005438042298;1126.5268587193398;1258.4462836352159;1269.3526301586073;1292.043887523226;736.4145504324075;876.9386142969931;887.0597167002868;890.1810334492283;893.5264309915755;5824.475797178275;5843.948089343874;5896.616719913192;5902.734376952962;6075.058365953284;923.7505873414141;935.91108844661;969.4038166527534;985.3201291109111;1004.5579944824254;4040.959590404117;4188.6649068074485;4192.287311157111;4243.490781106287;4341.45731783527;9872.950635246778;10056.949715251378;10069.446180459998;10139.949300253451;10180.592776288866;10033.698989030341;10037.749056273651;10037.949810250902;10053.547590358452;10062.69811905644;7440.2931721486375;7707.807304817425;7709.151993280847;7722.343600793995;7780.766577002699;6030.095485677183;6213.099100630474;6285.654289014148;6317.147185130132;6341.556091073765;9669.129778319704;9695.321327507007;9709.563069662023;9746.658866939622;9811.067948544876;9731.756706082122;9919.950400247953;9995.300328977193;10132.89867101349;10134.189264858942;6487.610743355413;7093.077899872984;7266.927330726837;7577.772666820004;7721.227877212234;8217.342612591097;8241.876371854307;8267.462614930011;8268.09051004401;8282.213189746964;7273.199948005609;7290.781276561712;7419.740309089156;7503.137139229058;7548.358389536951;7175.354218120394;7307.159676637255;7328.890066649111;7366.373858221897;7396.038514993016;6786.694598743167;6789.898151527632;6829.317068293131;6846.383825455534;6850.451963842781;4899.902001959869;4965.379327584052;5102.387713474407;5154.407243166934;5163;5019.874503137305;5059.392872855281;5112.875167463301;5138;5158.948410515847 09:30:51 INFO - PROCESS | 12871 | |4;prototype.html;327.96720327967205;331.724668525124;336.93429781192646;340.40429248814564;341.0331709603273;5329.413764485904;5346.251524786533;5364.785408583657;5368.275282836816;5438.53772429344;5296.390915044771;5320.255164276995;5363;5381.327334083239;5387.757550910209;4006.8998275043064;4032.9395059074136;4154.792260386984;4180.749155050707;4230.619244268015;4129.834806607732;4143.958560414402;4164.437800896885;4192.979035104835;4196.286631272676;3952.980235098835;4121.608447197526;4146.594974914542;4147.730397524167;4169.436461327003;4048.9797551012202;4089.20260549193;4102.405151253051;4198.32826747722;4204.8528301509305;3711.9072023199637;3719.516462859811;3731.794751288678;3734.7012239020814;3737.3646480098178;5133.844884900905;5202.583793296527;5241;5244.449332820037;5261.526462618344;4715.575598196145;4778.904421911542;4800.591949684281;4803.639727020487;4805.831795887128;5478.91781623276;5536.667799931976;5569.832905012856;5569.944300556983;5604.131359639263;4104.938425923614;4106.445629839964;4114.136031433402;4121.752694838319;4124.154548317588;5541.445855414467;5736.2542869427125;5769.4999300181835;5786.826395208151;5811.418858114197;4102.5692302307825;4142.896427589334;4157;4158.708890377645;4163.271427500175;4220.767857767853;4221.64116050133;4225.852095176654;4233.7883105844585;4234.343676730112;4683.95316046842;4790.856274311776;4792.353032340659;4799.928001079987;4810.687305325143;5660.009498337775;5673.375928647845;5684.919865225594;5688.488036076773;5705.71471426427;1474.2481334519473;1489.0767724011182;1491.7991017231016;1493.491573510762;1510.3882927414415;932.8414169591185;963.7205210488879;967.2938754709102;971.3880255439028;974.3617930255693;5382.650127741685;5503.642263252876;5539.612227144142;5565.471280228453;5567.610267281251;5792.913106303409;5796.710164491843;5812.564057695689;5818.359980402152;5819.341487675992;5228.797376603403;5481.492589537829;5522.751476183501;5531.8893622128135;5545.334559852843;2986.970130298713;3019.124453908386;3037.119235421703;3055.9388812223633;3064.6935306469177;5718.228039214653;5966.910496342558;6015.488683461867;6035.577509574287;6056.36408177135;5797.449242321973;5817.3019237690905;5822.272215973004;5834.212381328552;5846.7076646167525;5916.526677865761;5965.552583556164;5967.076132694948;6004.549658775697;6007.639541627516;5636.526836235266;5646.971765141148;5733.569982251264;5740.885182296247;5753.539716822561;5656.8020119295625;5684.261046063985;5712.314522257356;5721.570882183936;5739.454751798572;5705.771769129355;5927.703614819328;5997.700114994145;6035.728392222449;6044.33512313654;3770.2836461072307;3784.7918364489115;3797.9430308544843;3814.961850381461;3820.3123437780355;5204.765785539584;5239.8516608191985;5265.447128051499;5276.577873770012;5280.445553216857;4846.539578740014;4922.310876477224;5005.874853128701;5020.799168033238;5040.747962601782;4981.028699403581;5014.774335155;5069.31564238823;5106.131957567297;5136.280920671184;4991.600671946163;5029.622778291569;5033.546980771748;5352.330958630171;5352.625316227826;5581.776728930798;5661.2923384576925;5673.74468148926;5675.290588676416;5694.515966142759;5513.526478318634;5529.778808847601;5532.3637781655625;5560.944390556205;5573.331200255995 09:30:51 INFO - PROCESS | 12871 | |5;yui.html;754.4341743692228;758.2644834510527;758.3684614388073;769.9499532530389;797.7327595255591;14222.786658200135;15448.845511544881;15476.148811815345;15520.223988800557;15523.379064837407;14905.478308259213;15033.92483037586;15070.698586028273;15086.170260635661;15090.924545377258;631.0660222870155;777.3625626985873;789.8499285135834;792.4294507954264;797.3342259213534;793.8094857234252;798.3054742374143;799.2367289238792;800.5956991719203;800.7597720683772;842.1872892658583;847.1993965702413;847.3983471735075;848.2492993700589;848.817504236589;651.4527796650813;803.9598020099;829.6639860856363;829.8630725930215;831.8752187171912;609.0985341694274;609.1259043272918;609.2627920216544;609.3327806052365;609.5093449772932;13951.58145255644;13975.231362275072;13984.300784960813;13998.370073346723;14004.089734167246;13976.860231397657;14074.648133796634;14242.501512447117;14313.57059288223;14517.491887783983;10545.525451354708;10872.67381978542;10963;11023.393713345762;11076.944615276872;4416.6025057744955;4498.572635599613;4570.337301091323;4591.586757191869;4670.509596492353;74338;78050;78303;78492;79389.20610793933;10726.839097413545;10855.728606784736;11261.71845703864;11274.718132046764;11461.54153833854;21128.683069753966;21472.24847130343;21610;21611.459713507287;21618.243361482273;8077.192280771993;8142.592870356577;8221.17788221173;8412.242898139197;8461.873071903927;4710.105080034782;4737.8341758038305;4737.857864264078;4742.762861856893;4881.609471242292;3412.8805491807666;3461.498082777983;3534.9823250883583;3535.6994655454573;3536.550014494045;506.344284152024;600.6006006005957;600.8287638023143;605.6608299352289;620.5501011766434;735.8381156145639;759.9696012159562;764.9502782319131;770.3490550484831;792.057506363861;10130.848037279447;10415.958404159675;10504.264701470824;10610.787784244427;10653.946730266454;638.9712462939179;678.0507289794228;727.788941207044;730.0655161393424;752.2778132992279;4703.17694403478;4728.976355118202;4747.643926705511;4751.263554149113;4769.904601907942;73190;73917.2608273921;74222.6288868563;74694.25305746982;75102.62448687722;81200.59399702963;113629;114455;114555.42722286502;115445;99627.00372996322;100142.49928750456;100253;100574.49712751535;103968;8755.299576033774;9044.186023257938;9424.528773561431;9613.327067105236;9860.506974651382;48610.270845938045;51302.74348628233;52636.47363526469;52924.735376322875;53328.4667153339;76572.61713691396;77227.61386193258;78402.21597784177;79366.6031669838;79686.4062718754;13302.933485332898;13462.192268463923;13850.16898986064;13913.234772087633;14001.5099471518;15060.246987650355;15296;15348.462803801813;15386.846131538541;15958.441454549034;14284.142951422948;14575;14882.18148001827;14944.252787360805;15140.545783626509;13904.37430315618;14216.644583885485;14330.49843255481;14927.179005154821;15164.469243576423;12926.741465170831;13059.542915997894;14065.507707230197;14590.635234118807;14759.262036898326;10837.403942782907;11043.337399756041;11258.887411126112;11351.21895135697;11406.885931140583;10873.673789786002;10963.451827408757;10989.61536346224;11122.666320010412;11132.276402033842 09:30:51 INFO - PROCESS | 12871 | __end_tp_report 09:30:51 INFO - PROCESS | 12871 | __start_cc_report 09:30:51 INFO - PROCESS | 12871 | _x_x_mozilla_cycle_collect,884 09:30:51 INFO - PROCESS | 12871 | __end_cc_report 09:30:51 INFO - PROCESS | 12871 | __startTimestamp1467995451682__endTimestamp 09:30:51 INFO - PROCESS | 12871 | 09:30:51 INFO - PROCESS | 12871 | ------- Summary: start ------- 09:30:51 INFO - PROCESS | 12871 | Number of tests: 6 09:30:51 INFO - PROCESS | 12871 | 09:30:51 INFO - PROCESS | 12871 | [#0] dojo.html Cycles:165 Average:5246.31 Median:5460.43 stddev:586.72 (10.7%) stddev-sans-first:561.93 09:30:51 INFO - PROCESS | 12871 | Values: 3020.1 3044.8 3054.6 3072.0 3083.4 5238.0 5272.4 5297.0 5382.2 5395.2 5213.4 5279.0 5280.8 5302.8 5341.4 4771.0 4795.8 4824.3 4833.4 4946.1 4874.7 4887.3 4915.1 4932.7 4954.9 4757.7 4778.9 4781.0 4814.1 4826.9 4767.4 4803.5 4871.3 4874.5 4916.2 4740.1 4740.8 4763.5 4794.5 4818.7 5097.6 5182.0 5194.0 5252.4 5258.9 5558.5 5565.7 5591.4 5592.8 5604.3 5522.6 5571.5 5672.5 5674.9 5678.9 5240.2 5281.6 5304.2 5319.7 5321.0 5788.9 5793.8 5804.9 5805.2 5822.9 5284.3 5464.8 5465.2 5552.2 5558.0 5676.8 5677.3 5685.5 5689.1 5695.8 5608.9 5612.5 5614.3 5620.1 5658.2 5509.8 5562.5 5620.4 5623.2 5626.0 4355.9 4358.6 4361.9 4362.6 4392.9 3835.8 3864.5 3875.6 3892.6 3896.2 5243.4 5252.3 5294.3 5304.4 5308.1 5589.7 5592.6 5601.2 5609.9 5659.6 5277.3 5301.3 5313.6 5321.3 5376.5 4787.8 4870.7 4910.0 4921.1 4947.6 5901.4 5902.2 5904.5 5911.0 5918.1 5704.5 5722.9 5723.3 5725.9 5728.2 5628.4 5766.0 5825.0 5826.8 5871.1 5504.3 5551.1 5554.6 5558.2 5562.5 5520.8 5661.8 5676.7 5677.6 5681.1 5451.5 5452.0 5460.4 5475.2 5478.5 5467.8 5468.8 5500.6 5522.1 5530.6 5324.5 5423.1 5435.4 5443.3 5491.8 5571.4 5620.9 5621.9 5668.1 5669.0 5499.5 5501.3 5501.3 5502.9 5504.8 09:30:51 INFO - PROCESS | 12871 | 09:30:51 INFO - PROCESS | 12871 | [#1] ext.html Cycles:180 Average:54795.38 Median:34515.15 stddev:111665.00 (323.5%) stddev-sans-first:111904.04 09:30:51 INFO - PROCESS | 12871 | Values: 572.8 584.9 605.9 614.8 621.8 30491.7 41875.8 42363.4 42433.8 42496.6 45035.8 45184.3 45257.0 45335.8 45441.3 7815.3 8983.0 9173.5 9178.0 10677.5 10545.7 10951.2 10964.4 10985.0 10989.4 11066.0 11104.8 11108.8 11111.7 11119.2 10992.3 11025.5 11038.1 11043.1 11043.4 10699.8 10779.7 10779.9 10781.3 10785.8 42674.1 42786.1 43164.8 43209.0 43241.4 3605.9 3690.6 3739.5 3831.9 4113.5 33377.8 33635.2 33957.7 33990.3 35015.8 4245.4 4247.2 4278.1 4290.2 4327.4 252518.0 252981.7 253388.0 254094.0 254569.0 30786.2 57765.0 58199.4 58473.7 58554.4 36389.8 36494.5 36561.5 36597.5 36605.0 14640.0 14720.9 14732.3 14734.1 14749.3 11041.6 12408.9 12705.9 12878.4 13182.1 8281.4 8392.8 8396.0 8442.4 8460.0 2918.9 2970.6 3196.4 3204.2 3273.0 1008.9 1047.7 1060.9 1080.1 1098.3 33197.3 33545.0 33696.8 33756.3 33851.2 1122.2 1143.0 1153.2 1154.4 1202.2 17272.7 17348.3 17537.6 17578.8 17589.8 596495.0 599854.0 600082.0 601032.0 604204.0 56225.0 56717.7 56753.4 56787.4 56847.7 1129.2 1313.7 1357.1 1358.5 1382.4 32482.4 33786.2 34232.3 34492.8 34537.5 49136.5 49829.0 49914.8 49940.0 49970.3 310764.0 316484.0 316916.0 317743.0 318104.0 23393.8 24031.6 25852.6 26512.7 26864.0 46922.5 46974.8 47509.3 47564.3 48182.0 38554.0 38646.6 38713.6 38742.8 38750.6 38365.4 38524.4 38654.4 38666.8 39514.2 39981.8 40803.8 40964.0 40975.8 41131.8 35261.3 36197.0 37233.3 37486.4 37552.8 28284.9 28301.7 28381.9 28436.3 28532.9 09:30:51 INFO - PROCESS | 12871 | 09:30:51 INFO - PROCESS | 12871 | [#2] jquery.html Cycles:180 Average:28420.81 Median:400.42 stddev:74479.55 (18600.5%) stddev-sans-first:74658.75 09:30:51 INFO - PROCESS | 12871 | Values: 390.8 394.5 399.9 401.0 415.9 13311.8 18939.2 20419.1 20693.6 20746.0 15143.3 15349.2 17238.7 19910.7 21086.9 5856.7 5926.7 6047.3 6047.6 6080.6 5832.2 5920.9 5935.6 5959.7 5972.6 4215.6 5934.5 6349.8 6611.1 6630.9 6545.3 6706.8 6747.3 6761.2 6802.0 5900.7 5973.4 6026.8 6038.9 6053.7 23803.3 23835.4 24611.8 24635.1 24738.9 2807.2 2813.8 2840.4 2867.2 2886.5 14820.9 15082.2 15321.9 15434.3 15592.0 1899.7 1983.6 2014.7 2109.7 2151.8 60894.7 65586.2 82798.6 86563.6 87575.6 11230.3 11349.4 11637.8 11684.3 11690.7 16086.4 16186.5 16254.9 16285.0 16286.5 8064.7 8263.3 8317.3 8329.7 8383.9 7839.7 7851.9 7868.3 7977.6 7993.0 4774.0 4935.3 4981.8 5006.2 5044.2 1943.4 1960.0 1962.5 1980.4 1987.9 967.0 970.6 988.4 1020.2 1056.4 20060.7 20472.8 20635.2 20651.7 20758.6 992.3 998.3 1001.4 1020.2 1060.3 10929.6 11500.6 11558.2 11609.1 11641.7 445026.0 449999.0 450953.0 452191.0 454277.0 93546.0 94186.0 95452.0 95786.0 97561.0 961.9 974.1 987.2 990.3 994.0 16332.9 18342.9 18354.0 18654.3 18895.9 42532.6 43573.0 43767.3 44240.0 44878.8 57121.0 58361.0 60610.1 61670.5 61991.7 8808.9 9082.3 9139.4 9176.0 9192.0 13495.7 14003.9 14198.2 14232.9 14434.7 12174.5 12554.3 12597.5 12790.7 12915.9 8656.8 11515.7 11911.4 12420.3 12450.4 12133.2 12511.4 12962.0 13038.9 13176.3 8734.9 8837.3 8884.7 9072.0 9417.1 9479.4 12703.0 12712.7 12713.9 12969.9 09:30:51 INFO - PROCESS | 12871 | 09:30:51 INFO - PROCESS | 12871 | [#3] mootools.html Cycles:180 Average:5569.01 Median:5074.26 stddev:3093.78 (61.0%) stddev-sans-first:3085.48 09:30:51 INFO - PROCESS | 12871 | Values: 1256.7 1459.3 1481.4 1616.1 1759.2 7821.8 8104.7 8132.6 8421.2 8463.0 8168.3 8371.2 8371.8 8372.5 8382.2 1993.5 2185.8 2268.9 2331.6 2367.1 2300.4 2304.3 2311.5 2321.3 2322.5 2287.1 2287.6 2325.7 2326.1 2329.4 1911.5 2137.8 2206.6 2216.4 2223.5 2260.3 2261.9 2270.8 2281.8 2283.1 8410.8 8495.2 8498.6 8505.3 8556.3 4953.2 5103.1 5152.5 5155.6 5157.1 3131.2 3248.1 3312.2 3318.5 3322.0 1057.1 1081.3 1093.1 1106.6 1113.0 11461.8 11523.4 11525.6 11531.5 11534.1 4364.5 4444.8 4516.0 4636.9 4645.3 9641.1 9641.4 9647.4 9652.0 9665.6 5052.0 5070.9 5072.2 5072.6 5075.9 4157.6 4568.3 4733.8 4737.8 4818.6 3744.8 3792.3 3820.7 3864.3 3882.7 1109.6 1126.5 1258.4 1269.4 1292.0 736.4 876.9 887.1 890.2 893.5 5824.5 5843.9 5896.6 5902.7 6075.1 923.8 935.9 969.4 985.3 1004.6 4041.0 4188.7 4192.3 4243.5 4341.5 9873.0 10056.9 10069.4 10139.9 10180.6 10033.7 10037.7 10037.9 10053.5 10062.7 7440.3 7707.8 7709.2 7722.3 7780.8 6030.1 6213.1 6285.7 6317.1 6341.6 9669.1 9695.3 9709.6 9746.7 9811.1 9731.8 9920.0 9995.3 10132.9 10134.2 6487.6 7093.1 7266.9 7577.8 7721.2 8217.3 8241.9 8267.5 8268.1 8282.2 7273.2 7290.8 7419.7 7503.1 7548.4 7175.4 7307.2 7328.9 7366.4 7396.0 6786.7 6789.9 6829.3 6846.4 6850.5 4899.9 4965.4 5102.4 5154.4 5163.0 5019.9 5059.4 5112.9 5138.0 5158.9 09:30:51 INFO - PROCESS | 12871 | 09:30:51 INFO - PROCESS | 12871 | [#4] prototype.html Cycles:180 Average:4675.81 Median:5263.49 stddev:1366.62 (26.0%) stddev-sans-first:1330.92 09:30:51 INFO - PROCESS | 12871 | Values: 328.0 331.7 336.9 340.4 341.0 5329.4 5346.3 5364.8 5368.3 5438.5 5296.4 5320.3 5363.0 5381.3 5387.8 4006.9 4032.9 4154.8 4180.7 4230.6 4129.8 4144.0 4164.4 4193.0 4196.3 3953.0 4121.6 4146.6 4147.7 4169.4 4049.0 4089.2 4102.4 4198.3 4204.9 3711.9 3719.5 3731.8 3734.7 3737.4 5133.8 5202.6 5241.0 5244.4 5261.5 4715.6 4778.9 4800.6 4803.6 4805.8 5478.9 5536.7 5569.8 5569.9 5604.1 4104.9 4106.4 4114.1 4121.8 4124.2 5541.4 5736.3 5769.5 5786.8 5811.4 4102.6 4142.9 4157.0 4158.7 4163.3 4220.8 4221.6 4225.9 4233.8 4234.3 4684.0 4790.9 4792.4 4799.9 4810.7 5660.0 5673.4 5684.9 5688.5 5705.7 1474.2 1489.1 1491.8 1493.5 1510.4 932.8 963.7 967.3 971.4 974.4 5382.7 5503.6 5539.6 5565.5 5567.6 5792.9 5796.7 5812.6 5818.4 5819.3 5228.8 5481.5 5522.8 5531.9 5545.3 2987.0 3019.1 3037.1 3055.9 3064.7 5718.2 5966.9 6015.5 6035.6 6056.4 5797.4 5817.3 5822.3 5834.2 5846.7 5916.5 5965.6 5967.1 6004.5 6007.6 5636.5 5647.0 5733.6 5740.9 5753.5 5656.8 5684.3 5712.3 5721.6 5739.5 5705.8 5927.7 5997.7 6035.7 6044.3 3770.3 3784.8 3797.9 3815.0 3820.3 5204.8 5239.9 5265.4 5276.6 5280.4 4846.5 4922.3 5005.9 5020.8 5040.7 4981.0 5014.8 5069.3 5106.1 5136.3 4991.6 5029.6 5033.5 5352.3 5352.6 5581.8 5661.3 5673.7 5675.3 5694.5 5513.5 5529.8 5532.4 5560.9 5573.3 09:30:51 INFO - PROCESS | 12871 | 09:30:51 INFO - PROCESS | 12871 | [#5] yui.html Cycles:180 Average:20539.21 Median:4580.96 stddev:29127.00 (635.8%) stddev-sans-first:29170.83 09:30:51 INFO - PROCESS | 12871 | Values: 754.4 758.3 758.4 769.9 797.7 14222.8 15448.8 15476.1 15520.2 15523.4 14905.5 15033.9 15070.7 15086.2 15090.9 631.1 777.4 789.8 792.4 797.3 793.8 798.3 799.2 800.6 800.8 842.2 847.2 847.4 848.2 848.8 651.5 804.0 829.7 829.9 831.9 609.1 609.1 609.3 609.3 609.5 13951.6 13975.2 13984.3 13998.4 14004.1 13976.9 14074.6 14242.5 14313.6 14517.5 10545.5 10872.7 10963.0 11023.4 11076.9 4416.6 4498.6 4570.3 4591.6 4670.5 74338.0 78050.0 78303.0 78492.0 79389.2 10726.8 10855.7 11261.7 11274.7 11461.5 21128.7 21472.2 21610.0 21611.5 21618.2 8077.2 8142.6 8221.2 8412.2 8461.9 4710.1 4737.8 4737.9 4742.8 4881.6 3412.9 3461.5 3535.0 3535.7 3536.6 506.3 600.6 600.8 605.7 620.6 735.8 760.0 765.0 770.3 792.1 10130.8 10416.0 10504.3 10610.8 10653.9 639.0 678.1 727.8 730.1 752.3 4703.2 4729.0 4747.6 4751.3 4769.9 73190.0 73917.3 74222.6 74694.3 75102.6 81200.6 113629.0 114455.0 114555.4 115445.0 99627.0 100142.5 100253.0 100574.5 103968.0 8755.3 9044.2 9424.5 9613.3 9860.5 48610.3 51302.7 52636.5 52924.7 53328.5 76572.6 77227.6 78402.2 79366.6 79686.4 13302.9 13462.2 13850.2 13913.2 14001.5 15060.2 15296.0 15348.5 15386.8 15958.4 14284.1 14575.0 14882.2 14944.3 15140.5 13904.4 14216.6 14330.5 14927.2 15164.5 12926.7 13059.5 14065.5 14590.6 14759.3 10837.4 11043.3 11258.9 11351.2 11406.9 10873.7 10963.5 10989.6 11122.7 11132.3 09:30:51 INFO - PROCESS | 12871 | -------- Summary: end -------- 09:30:51 INFO - PROCESS | 12871 | 09:30:52 INFO - TEST-INFO | 12871: exit 0 09:30:52 INFO - TEST-OK | dromaeo_css | took 1112772ms 09:30:52 INFO - TEST-START | kraken 09:30:52 INFO - operating with platform_type : linux_ 09:30:52 INFO - Initialising browser for kraken test... 09:30:52 INFO - TEST-INFO | started process 13073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL5RKth/profile http://localhost:47956/getInfo.html) 09:30:56 INFO - PROCESS | 13073 | __metrics Screen width/height:1600/1200 09:30:56 INFO - PROCESS | 13073 | colorDepth:24 09:30:56 INFO - PROCESS | 13073 | Browser inner width/height: 1024/697 09:30:56 INFO - PROCESS | 13073 | __metrics 09:30:57 INFO - PROCESS | 13073 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:30:58 INFO - TEST-INFO | 13073: exit 0 09:30:58 INFO - Browser initialized. 09:30:58 INFO - Running cycle 1/1 for kraken test... 09:30:58 INFO - TEST-INFO | started process 13155 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL5RKth/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:31:09 INFO - PROCESS | 13155 | RSS: Main: 157138944 09:31:09 INFO - PROCESS | 13155 | 09:31:12 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47956/tests/kraken/driver.html?testName=audio-beat-detection) 09:31:13 INFO - PROCESS | 13155 | RSS: Main: 215228416 09:31:13 INFO - PROCESS | 13155 | 09:31:15 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47956/tests/kraken/driver.html?testName=audio-dft) 09:31:16 INFO - PROCESS | 13155 | RSS: Main: 202645504 09:31:16 INFO - PROCESS | 13155 | 09:31:19 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47956/tests/kraken/driver.html?testName=audio-fft) 09:31:20 INFO - PROCESS | 13155 | RSS: Main: 270319616 09:31:20 INFO - PROCESS | 13155 | 09:31:22 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47956/tests/kraken/driver.html?testName=audio-oscillator) 09:31:22 INFO - PROCESS | 13155 | RSS: Main: 180101120 09:31:22 INFO - PROCESS | 13155 | 09:31:25 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47956/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:31:25 INFO - PROCESS | 13155 | RSS: Main: 183848960 09:31:25 INFO - PROCESS | 13155 | 09:31:28 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47956/tests/kraken/driver.html?testName=imaging-darkroom) 09:31:29 INFO - PROCESS | 13155 | RSS: Main: 218849280 09:31:29 INFO - PROCESS | 13155 | 09:31:32 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47956/tests/kraken/driver.html?testName=imaging-desaturate) 09:31:33 INFO - PROCESS | 13155 | RSS: Main: 220782592 09:31:33 INFO - PROCESS | 13155 | 09:31:36 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47956/tests/kraken/driver.html?testName=json-parse-financial) 09:31:36 INFO - PROCESS | 13155 | RSS: Main: 220999680 09:31:36 INFO - PROCESS | 13155 | 09:31:38 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47956/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:31:38 INFO - PROCESS | 13155 | RSS: Main: 207777792 09:31:38 INFO - PROCESS | 13155 | 09:31:40 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47956/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:31:41 INFO - PROCESS | 13155 | RSS: Main: 213127168 09:31:41 INFO - PROCESS | 13155 | 09:31:43 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47956/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:31:43 INFO - PROCESS | 13155 | RSS: Main: 212582400 09:31:43 INFO - PROCESS | 13155 | 09:31:46 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47956/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:31:47 INFO - PROCESS | 13155 | RSS: Main: 226885632 09:31:47 INFO - PROCESS | 13155 | 09:31:49 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47956/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:31:50 INFO - PROCESS | 13155 | RSS: Main: 226549760 09:31:50 INFO - PROCESS | 13155 | 09:31:51 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:47956/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47956/tests/kraken/driver.html?testName=ai-astar) 09:31:52 INFO - PROCESS | 13155 | RSS: Main: 269463552 09:31:52 INFO - PROCESS | 13155 | 09:31:52 INFO - PROCESS | 13155 | __start_tp_report 09:31:52 INFO - PROCESS | 13155 | _x_x_mozilla_page_load 09:31:52 INFO - PROCESS | 13155 | _x_x_mozilla_page_load_details 09:31:52 INFO - PROCESS | 13155 | |i|pagename|runs| 09:31:52 INFO - PROCESS | 13155 | |0;ai-astar;101;112;109;110;112;111;112;114;111;113 09:31:52 INFO - PROCESS | 13155 | |1;audio-beat-detection;153;119;120;180;118;116;149;123;162;118 09:31:52 INFO - PROCESS | 13155 | |2;audio-dft;162;160;160;160;159;160;162;160;162;161 09:31:52 INFO - PROCESS | 13155 | |3;audio-fft;75;75;76;122;76;76;74;74;101;75 09:31:52 INFO - PROCESS | 13155 | |4;audio-oscillator;84;84;118;84;84;84;116;84;84;120 09:31:52 INFO - PROCESS | 13155 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;117;117 09:31:52 INFO - PROCESS | 13155 | |6;imaging-darkroom;146;146;146;145;146;146;146;146;146;146 09:31:52 INFO - PROCESS | 13155 | |7;imaging-desaturate;96;95;95;96;95;96;95;95;95;96 09:31:52 INFO - PROCESS | 13155 | |8;json-parse-financial;54;55;53;52;53;54;53;54;54;63 09:31:52 INFO - PROCESS | 13155 | |9;json-stringify-tinderbox;59;60;60;60;60;60;59;59;59;60 09:31:52 INFO - PROCESS | 13155 | |10;stanford-crypto-aes;84;77;81;78;87;74;75;83;74;85 09:31:52 INFO - PROCESS | 13155 | |11;stanford-crypto-ccm;117;118;118;129;118;118;122;120;159;119 09:31:52 INFO - PROCESS | 13155 | |12;stanford-crypto-pbkdf2;159;156;156;155;158;154;159;154;154;156 09:31:52 INFO - PROCESS | 13155 | |13;stanford-crypto-sha256-iterative;62;62;66;62;62;62;62;62;61;60 09:31:52 INFO - PROCESS | 13155 | __end_tp_report 09:31:52 INFO - PROCESS | 13155 | __start_cc_report 09:31:52 INFO - PROCESS | 13155 | _x_x_mozilla_cycle_collect,1633 09:31:52 INFO - PROCESS | 13155 | __end_cc_report 09:31:52 INFO - PROCESS | 13155 | __startTimestamp1467995512237__endTimestamp 09:31:52 INFO - PROCESS | 13155 | 09:31:52 INFO - PROCESS | 13155 | ------- Summary: start ------- 09:31:52 INFO - PROCESS | 13155 | Number of tests: 14 09:31:52 INFO - PROCESS | 13155 | 09:31:52 INFO - PROCESS | 13155 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.63 (3.2%) stddev-sans-first:1.51 09:31:52 INFO - PROCESS | 13155 | Values: 101.0 112.0 109.0 110.0 112.0 111.0 112.0 114.0 111.0 113.0 09:31:52 INFO - PROCESS | 13155 | 09:31:52 INFO - PROCESS | 13155 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:136.00 stddev:23.17 (17.0%) stddev-sans-first:23.72 09:31:52 INFO - PROCESS | 13155 | Values: 153.0 119.0 120.0 180.0 118.0 116.0 149.0 123.0 162.0 118.0 09:31:52 INFO - PROCESS | 13155 | 09:31:52 INFO - PROCESS | 13155 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.07 (0.7%) stddev-sans-first:1.01 09:31:52 INFO - PROCESS | 13155 | Values: 162.0 160.0 160.0 160.0 159.0 160.0 162.0 160.0 162.0 161.0 09:31:52 INFO - PROCESS | 13155 | 09:31:52 INFO - PROCESS | 13155 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:16.13 (21.5%) stddev-sans-first:16.89 09:31:52 INFO - PROCESS | 13155 | Values: 75.0 75.0 76.0 122.0 76.0 76.0 74.0 74.0 101.0 75.0 09:31:52 INFO - PROCESS | 13155 | 09:31:52 INFO - PROCESS | 13155 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:84.00 stddev:16.45 (19.6%) stddev-sans-first:17.03 09:31:52 INFO - PROCESS | 13155 | Values: 84.0 84.0 118.0 84.0 84.0 84.0 116.0 84.0 84.0 120.0 09:31:52 INFO - PROCESS | 13155 | 09:31:52 INFO - PROCESS | 13155 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:31:52 INFO - PROCESS | 13155 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 09:31:52 INFO - PROCESS | 13155 | 09:31:52 INFO - PROCESS | 13155 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 09:31:52 INFO - PROCESS | 13155 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 09:31:52 INFO - PROCESS | 13155 | 09:31:52 INFO - PROCESS | 13155 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:31:52 INFO - PROCESS | 13155 | Values: 96.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 96.0 09:31:52 INFO - PROCESS | 13155 | 09:31:52 INFO - PROCESS | 13155 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:3.10 (5.7%) stddev-sans-first:3.28 09:31:52 INFO - PROCESS | 13155 | Values: 54.0 55.0 53.0 52.0 53.0 54.0 53.0 54.0 54.0 63.0 09:31:52 INFO - PROCESS | 13155 | 09:31:52 INFO - PROCESS | 13155 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 09:31:52 INFO - PROCESS | 13155 | Values: 59.0 60.0 60.0 60.0 60.0 60.0 59.0 59.0 59.0 60.0 09:31:52 INFO - PROCESS | 13155 | 09:31:52 INFO - PROCESS | 13155 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:82.00 stddev:4.83 (5.9%) stddev-sans-first:4.87 09:31:52 INFO - PROCESS | 13155 | Values: 84.0 77.0 81.0 78.0 87.0 74.0 75.0 83.0 74.0 85.0 09:31:52 INFO - PROCESS | 13155 | 09:31:52 INFO - PROCESS | 13155 | [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:119.50 stddev:12.86 (10.8%) stddev-sans-first:13.40 09:31:52 INFO - PROCESS | 13155 | Values: 117.0 118.0 118.0 129.0 118.0 118.0 122.0 120.0 159.0 119.0 09:31:52 INFO - PROCESS | 13155 | 09:31:52 INFO - PROCESS | 13155 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.10 Median:156.00 stddev:1.97 (1.3%) stddev-sans-first:1.79 09:31:52 INFO - PROCESS | 13155 | Values: 159.0 156.0 156.0 155.0 158.0 154.0 159.0 154.0 154.0 156.0 09:31:52 INFO - PROCESS | 13155 | 09:31:52 INFO - PROCESS | 13155 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.52 (2.5%) stddev-sans-first:1.62 09:31:52 INFO - PROCESS | 13155 | Values: 62.0 62.0 66.0 62.0 62.0 62.0 62.0 62.0 61.0 60.0 09:31:52 INFO - PROCESS | 13155 | -------- Summary: end -------- 09:31:52 INFO - PROCESS | 13155 | 09:31:53 INFO - TEST-INFO | 13155: exit 0 09:31:53 INFO - TEST-OK | kraken | took 60811ms 09:31:53 INFO - SUITE-END | took 1173s 09:31:53 INFO - Completed test suite (00:19:33) 09:31:53 INFO - javascript benchmark 09:31:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3020.1090678249916, 3044.8020878642874, 3054.6334439867214, 3072.0323098224044, 3083.3679095785365, 5238.0, 5272.420033796289, 5297.0, 5382.192671099337, 5395.244665746799, 5213.3743950725875, 5279.0, 5280.841574752763, 5302.814401495948, 5341.385740639827, 4771.045790841837, 4795.808167673289, 4824.276358546211, 4833.419989601252, 4946.109700253953, 4874.65877388583, 4887.340209071783, 4915.066137433894, 4932.728699921503, 4954.900901981958, 4757.666963312552, 4778.904421911577, 4781.0, 4814.085323788504, 4826.927596086061, 4767.427908650984, 4803.519648035203, 4871.318015477836, 4874.512548745132, 4916.1888288432365, 4740.1230772307235, 4740.834070807539, 4763.49983251757, 4794.472608013116, 4818.734969576672, 5097.592192624618, 5182.041322355376, 5194.039102766001, 5252.422233554306, 5258.947410525884, 5558.471945165203, 5565.693886836222, 5591.3569939457075, 5592.804251851207, 5604.299462567179, 5522.585806064521, 5571.498565129158, 5672.546196304327, 5674.886502269973, 5678.914816277759, 5240.213967904845, 5281.577473802086, 5304.151335786294, 5319.7340132993195, 5321.015612111772, 5788.855278617984, 5793.797217097465, 5804.854878628068, 5805.216295800097, 5822.854428639318, 5284.339457567804, 5464.754086066137, 5465.152901300305, 5552.167174923794, 5558.0, 5676.829695109153, 5677.3471050829685, 5685.459881311352, 5689.118186681071, 5695.800646977336, 5608.9439105609235, 5612.5229355504425, 5614.29821272341, 5620.128880023522, 5658.151277308354, 5509.752061157257, 5562.471565201299, 5620.409856965041, 5623.184638227516, 5625.971870140623, 4355.869323920288, 4358.585934336233, 4361.869143925687, 4362.585554372329, 4392.912141757147, 3835.8465661373234, 3864.516935383077, 3875.5930627284292, 3892.552356479041, 3896.2207558488417, 5243.449437809051, 5252.29094072303, 5294.338207724035, 5304.416514183436, 5308.0710875596615, 5589.692566908778, 5592.608517403743, 5601.243832082698, 5609.943900561024, 5659.603827732101, 5277.313949186581, 5301.257823904656, 5313.57491400687, 5321.281626980385, 5376.516113549799, 4787.808487660454, 4870.659053866196, 4910.042541704333, 4921.138800709861, 4947.5794557462295, 5901.409859014064, 5902.173695682608, 5904.527637788967, 5911.024680927599, 5918.082697181943, 5704.458076482728, 5722.914156287576, 5723.284589426322, 5725.885482290414, 5728.198052272768, 5628.437156284503, 5766.048601980626, 5824.9708751457665, 5826.796062137805, 5871.1486834407915, 5504.256925315031, 5551.084071128219, 5554.555635549065, 5558.194061860927, 5562.471565201299, 5520.7515661796115, 5661.773529058792, 5676.744546495335, 5677.602567820378, 5681.0910254359105, 5451.536619387396, 5452.045891968969, 5460.426655201306, 5475.151351540518, 5478.479544443271, 5467.835964921059, 5468.7539060741565, 5500.559955203494, 5522.088855338824, 5530.6128570999645, 5324.4675532446445, 5423.050966080999, 5435.402105768441, 5443.265159203457, 5491.780328786804, 5571.415001424792, 5620.859478512906, 5621.887562248814, 5668.121441176624, 5668.971655141698, 5499.450054994469, 5501.284832971848, 5501.312335958005, 5502.889942201214, 5504.779808807602], "value": 5207.11986178427, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.831014850619, 584.8800995795863, 605.9394060593941, 614.7633161232924, 621.7668374359612, 30491.695083049162, 41875.790621046894, 42363.36454953178, 42433.78783106084, 42496.57503424965, 45035.77482112585, 45184.322235166495, 45257.0, 45335.77332113343, 45441.31838022432, 7815.2966233039015, 8982.955085224565, 9173.495457749854, 9178.036306187854, 10677.519511621957, 10545.683629491128, 10951.233413661046, 10964.396958167297, 10985.0, 10989.395583242918, 11066.0, 11104.833427498594, 11108.833367499494, 11111.72220694481, 11119.1660625453, 10992.28550144238, 11025.503852326665, 11038.11695064393, 11043.061339786127, 11043.3926134063, 10699.786004279871, 10779.730506737316, 10779.892201077968, 10781.299215550964, 10785.78428431427, 42674.14651706949, 42786.14427711428, 43164.784176078916, 43209.0, 43241.35137972933, 3605.855765769366, 3690.5755838078426, 3739.5325584301963, 3831.9042023949346, 4113.547509773923, 33377.83311083429, 33635.15912102193, 33957.6604233957, 33990.32019359599, 35015.824920875486, 4245.405643209953, 4247.193033323659, 4278.080212754242, 4290.163418133465, 4327.3725309830215, 252518.0, 252981.73509132522, 253388.0, 254094.0, 254569.0, 30786.230344241572, 57765.0, 58199.4180058194, 58473.70763146157, 58554.414455855745, 36389.81805090958, 36494.45258321127, 36561.45157822635, 36597.451038234445, 36605.0, 14640.0, 14720.852791471949, 14732.337044833008, 14734.115953042852, 14749.262536873113, 11041.613543525938, 12408.875911240772, 12705.872941270654, 12878.356082195853, 13182.143160694524, 8281.37889658278, 8392.79018024542, 8396.0, 8442.409031367868, 8459.957700211582, 2918.8832446702318, 2970.613820203403, 3196.376706542202, 3204.1829333519804, 3272.9836350818096, 1008.9394636321845, 1047.6909311753052, 1060.9363438193734, 1080.1304949515559, 1098.280626189847, 33197.3360532788, 33545.0, 33696.83151584226, 33756.324873502395, 33851.153721156676, 1122.2256642916361, 1142.971425714347, 1153.2042890405594, 1154.440096553171, 1202.1524824998355, 17272.65454690899, 17348.30606775715, 17537.56156096108, 17578.824211757717, 17589.824101759074, 596495.0, 599854.0, 600082.0, 601032.0, 604204.0, 56225.0, 56717.71641141851, 56753.43246567564, 56787.43212567904, 56847.71576142093, 1129.209553312668, 1313.6978494946216, 1357.0704067713648, 1358.4634069542476, 1382.4055656067787, 32482.35035299328, 33786.155346116546, 34232.31535369329, 34492.82753586216, 34537.48193777045, 49136.50863491462, 49829.0, 49914.750426247636, 49940.0, 49970.25044624261, 310764.0, 316484.0, 316916.0, 317743.0, 318104.0, 23393.76606233984, 24031.639525406783, 25852.61221081648, 26512.734872651028, 26864.0, 46922.53077469182, 46974.76512617415, 47509.287360688926, 47564.28653570268, 48182.0, 38554.0, 38646.6135338643, 38713.61286387213, 38742.80628596839, 38750.6124938747, 38365.424518632804, 38524.42213366858, 38654.42018369783, 38666.80666596649, 39514.2097158061, 39981.80009099936, 40803.7959810199, 40964.0, 40975.795121025396, 41131.7943410281, 35261.294774104885, 36197.0, 37233.25533489369, 37486.43770343393, 37552.81223593865, 28284.85857570699, 28301.71698282991, 28381.85809071024, 28436.289092772848, 28532.85733571319], "value": 18976.68915975757, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.82412914188586, 394.5364197068446, 399.8620475935801, 400.96992725545584, 415.8835526052706, 13311.800322995163, 18939.242430302787, 20419.081141348637, 20693.586128277446, 20746.0, 15143.318550665219, 15349.232538373093, 17238.741418878726, 19910.701339479918, 21086.89456552719, 5856.707164641773, 5926.674032928187, 6047.304559975593, 6047.606905551147, 6080.604760690563, 5832.154337621042, 5920.88158236835, 5935.643861368331, 5959.70201489926, 5972.611780234271, 4215.620594146526, 5934.495567876736, 6349.809505714813, 6611.107500487445, 6630.93369066308, 6545.280019197884, 6706.765263215789, 6747.291534388867, 6761.188657361099, 6802.0, 5900.704964751745, 5973.402659734035, 6026.8493287667725, 6038.879222415571, 6053.69731513427, 23803.285901422983, 23835.404114897094, 24611.753882461126, 24635.137770177957, 24738.876305618356, 2807.1859160843333, 2813.788965827551, 2840.389316297006, 2867.240181351943, 2886.494863398918, 14820.851791482162, 15082.170480623561, 15321.923390383088, 15434.305456254495, 15592.0, 1899.67705490067, 1983.5735316906935, 2014.687723402875, 2109.7257356543705, 2151.817095546865, 60894.695526522526, 65586.22186273163, 82798.58600707017, 86563.56718216432, 87575.56212218961, 11230.270032448028, 11349.432528373549, 11637.825432618518, 11684.298942063504, 11690.70773230676, 16086.35654573804, 16186.514404567883, 16254.918725406298, 16285.0, 16286.51140465788, 8064.677412903536, 8263.256306932404, 8317.293030092389, 8329.708460203863, 8383.916160838435, 7839.725609603636, 7851.921480785233, 7868.25251601097, 7977.561234132062, 7993.0, 4774.0, 4935.284383764334, 4981.775820088104, 5006.249062640633, 5044.218146187347, 1943.3878328326532, 1959.970600440966, 1962.4995626115249, 1980.4355758608726, 1987.9403617891487, 966.9613215471302, 970.5632465390603, 988.3773222869546, 1020.2195320579763, 1056.413690401819, 20060.696054756394, 20472.79527204709, 20635.17459301641, 20651.69022464664, 20758.58482830335, 992.3053862296422, 998.2912132385942, 1001.4241810958728, 1020.1991436722286, 1060.2684147937898, 10929.617463388902, 11500.59747908836, 11558.248713833742, 11609.071274298036, 11641.708957275967, 445026.0, 449999.0, 450953.0, 452191.0, 454277.0, 93546.0, 94186.0, 95452.0, 95786.0, 97561.0, 961.9374740641836, 974.0940924939732, 987.170776547689, 990.2968892086699, 994.0109590957044, 16332.918335408247, 18342.90828545849, 18354.0, 18654.34709785151, 18895.905520472308, 42532.574674252864, 43573.0, 43767.34348984832, 44240.0, 44878.77560612176, 57121.0, 58361.0, 60610.09084863819, 61670.52459491868, 61991.690041549504, 8808.91191088081, 9082.318826088202, 9139.360244782802, 9175.954120229357, 9191.954040229755, 13495.730085398434, 14003.859961400663, 14198.219097949712, 14232.928835355757, 14434.711305774035, 12174.513019479122, 12554.309512976874, 12597.496100155891, 12790.74418511606, 12915.870841291468, 8656.783580410289, 11515.654530364103, 11911.40442977865, 12420.254784712946, 12450.439730212343, 12133.21134126279, 12511.374431278582, 12962.0, 13038.869611303766, 13176.341182940623, 8734.91265087341, 8837.293016558788, 8884.73345799627, 9072.047435019227, 9417.105374989365, 9479.383840050376, 12703.0, 12712.6821829455, 12713.93643031779, 12969.870301297244], "value": 9645.178124243683, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1256.6795467155873, 1459.2630721485652, 1481.3704175725318, 1616.1272912627182, 1759.1995641982908, 7821.804454888624, 8104.716334928279, 8132.552709600977, 8421.19998600132, 8463.0, 8168.264856162944, 8371.162883711626, 8371.790705232372, 8372.455790373622, 8382.203690649394, 1993.531520092777, 2185.7595664476894, 2268.897899594514, 2331.5803155432013, 2367.0531787285054, 2300.4133945843787, 2304.3087073877855, 2311.456807650201, 2321.2688003279, 2322.4890524084676, 2287.0623044551735, 2287.576798292321, 2325.732540757809, 2326.057946531649, 2329.3594261578032, 1911.4552352579517, 2137.775533568984, 2206.6359050756605, 2216.357256395643, 2223.54417344444, 2260.2654137405243, 2261.8642881427168, 2270.8069814065825, 2281.783230593091, 2283.1095872609694, 8410.83178336436, 8495.192956669107, 8498.575071246474, 8505.277051450634, 8556.272716819078, 4953.182724850395, 5103.132467480537, 5152.510511501401, 5155.561777248939, 5157.123289040872, 3131.18589166816, 3248.1067706380936, 3312.205070782995, 3318.452455344865, 3322.0, 1057.1014637558092, 1081.259337353915, 1093.103655002898, 1106.6292791914718, 1112.9871816646812, 11461.770764584746, 11523.42382880861, 11525.596604118815, 11531.481083351186, 11534.134939879543, 4364.454443194601, 4444.844430444984, 4516.029053753458, 4636.86089417318, 4645.256758918556, 9641.084097010773, 9641.37331073492, 9647.421154730739, 9651.951740241253, 9665.565049572786, 5052.0, 5070.898582028339, 5072.163093089673, 5072.644914855925, 5075.87310317245, 4157.584241575818, 4568.33759104928, 4733.810647574127, 4737.810487580458, 4818.590419814285, 3744.756590821588, 3792.2605092007348, 3820.675242604354, 3864.343061679465, 3882.7476214045996, 1109.6005438042298, 1126.5268587193398, 1258.4462836352159, 1269.3526301586073, 1292.043887523226, 736.4145504324075, 876.9386142969931, 887.0597167002868, 890.1810334492283, 893.5264309915755, 5824.475797178275, 5843.948089343874, 5896.616719913192, 5902.734376952962, 6075.058365953284, 923.7505873414141, 935.91108844661, 969.4038166527534, 985.3201291109111, 1004.5579944824254, 4040.959590404117, 4188.6649068074485, 4192.287311157111, 4243.490781106287, 4341.45731783527, 9872.950635246778, 10056.949715251378, 10069.446180459998, 10139.949300253451, 10180.592776288866, 10033.698989030341, 10037.749056273651, 10037.949810250902, 10053.547590358452, 10062.69811905644, 7440.2931721486375, 7707.807304817425, 7709.151993280847, 7722.343600793995, 7780.766577002699, 6030.095485677183, 6213.099100630474, 6285.654289014148, 6317.147185130132, 6341.556091073765, 9669.129778319704, 9695.321327507007, 9709.563069662023, 9746.658866939622, 9811.067948544876, 9731.756706082122, 9919.950400247953, 9995.300328977193, 10132.89867101349, 10134.189264858942, 6487.610743355413, 7093.077899872984, 7266.927330726837, 7577.772666820004, 7721.227877212234, 8217.342612591097, 8241.876371854307, 8267.462614930011, 8268.09051004401, 8282.213189746964, 7273.199948005609, 7290.781276561712, 7419.740309089156, 7503.137139229058, 7548.358389536951, 7175.354218120394, 7307.159676637255, 7328.890066649111, 7366.373858221897, 7396.038514993016, 6786.694598743167, 6789.898151527632, 6829.317068293131, 6846.383825455534, 6850.451963842781, 4899.902001959869, 4965.379327584052, 5102.387713474407, 5154.407243166934, 5163.0, 5019.874503137305, 5059.392872855281, 5112.875167463301, 5138.0, 5158.948410515847], "value": 4478.135711749426, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.96720327967205, 331.724668525124, 336.93429781192646, 340.40429248814564, 341.0331709603273, 5329.413764485904, 5346.251524786533, 5364.785408583657, 5368.275282836816, 5438.53772429344, 5296.390915044771, 5320.255164276995, 5363.0, 5381.327334083239, 5387.757550910209, 4006.8998275043064, 4032.9395059074136, 4154.792260386984, 4180.749155050707, 4230.619244268015, 4129.834806607732, 4143.958560414402, 4164.437800896885, 4192.979035104835, 4196.286631272676, 3952.980235098835, 4121.608447197526, 4146.594974914542, 4147.730397524167, 4169.436461327003, 4048.9797551012202, 4089.20260549193, 4102.405151253051, 4198.32826747722, 4204.8528301509305, 3711.9072023199637, 3719.516462859811, 3731.794751288678, 3734.7012239020814, 3737.3646480098178, 5133.844884900905, 5202.583793296527, 5241.0, 5244.449332820037, 5261.526462618344, 4715.575598196145, 4778.904421911542, 4800.591949684281, 4803.639727020487, 4805.831795887128, 5478.91781623276, 5536.667799931976, 5569.832905012856, 5569.944300556983, 5604.131359639263, 4104.938425923614, 4106.445629839964, 4114.136031433402, 4121.752694838319, 4124.154548317588, 5541.445855414467, 5736.2542869427125, 5769.4999300181835, 5786.826395208151, 5811.418858114197, 4102.5692302307825, 4142.896427589334, 4157.0, 4158.708890377645, 4163.271427500175, 4220.767857767853, 4221.64116050133, 4225.852095176654, 4233.7883105844585, 4234.343676730112, 4683.95316046842, 4790.856274311776, 4792.353032340659, 4799.928001079987, 4810.687305325143, 5660.009498337775, 5673.375928647845, 5684.919865225594, 5688.488036076773, 5705.71471426427, 1474.2481334519473, 1489.0767724011182, 1491.7991017231016, 1493.491573510762, 1510.3882927414415, 932.8414169591185, 963.7205210488879, 967.2938754709102, 971.3880255439028, 974.3617930255693, 5382.650127741685, 5503.642263252876, 5539.612227144142, 5565.471280228453, 5567.610267281251, 5792.913106303409, 5796.710164491843, 5812.564057695689, 5818.359980402152, 5819.341487675992, 5228.797376603403, 5481.492589537829, 5522.751476183501, 5531.8893622128135, 5545.334559852843, 2986.970130298713, 3019.124453908386, 3037.119235421703, 3055.9388812223633, 3064.6935306469177, 5718.228039214653, 5966.910496342558, 6015.488683461867, 6035.577509574287, 6056.36408177135, 5797.449242321973, 5817.3019237690905, 5822.272215973004, 5834.212381328552, 5846.7076646167525, 5916.526677865761, 5965.552583556164, 5967.076132694948, 6004.549658775697, 6007.639541627516, 5636.526836235266, 5646.971765141148, 5733.569982251264, 5740.885182296247, 5753.539716822561, 5656.8020119295625, 5684.261046063985, 5712.314522257356, 5721.570882183936, 5739.454751798572, 5705.771769129355, 5927.703614819328, 5997.700114994145, 6035.728392222449, 6044.33512313654, 3770.2836461072307, 3784.7918364489115, 3797.9430308544843, 3814.961850381461, 3820.3123437780355, 5204.765785539584, 5239.8516608191985, 5265.447128051499, 5276.577873770012, 5280.445553216857, 4846.539578740014, 4922.310876477224, 5005.874853128701, 5020.799168033238, 5040.747962601782, 4981.028699403581, 5014.774335155, 5069.31564238823, 5106.131957567297, 5136.280920671184, 4991.600671946163, 5029.622778291569, 5033.546980771748, 5352.330958630171, 5352.625316227826, 5581.776728930798, 5661.2923384576925, 5673.74468148926, 5675.290588676416, 5694.515966142759, 5513.526478318634, 5529.778808847601, 5532.3637781655625, 5560.944390556205, 5573.331200255995], "value": 4245.178947519577, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.4341743692228, 758.2644834510527, 758.3684614388073, 769.9499532530389, 797.7327595255591, 14222.786658200135, 15448.845511544881, 15476.148811815345, 15520.223988800557, 15523.379064837407, 14905.478308259213, 15033.92483037586, 15070.698586028273, 15086.170260635661, 15090.924545377258, 631.0660222870155, 777.3625626985873, 789.8499285135834, 792.4294507954264, 797.3342259213534, 793.8094857234252, 798.3054742374143, 799.2367289238792, 800.5956991719203, 800.7597720683772, 842.1872892658583, 847.1993965702413, 847.3983471735075, 848.2492993700589, 848.817504236589, 651.4527796650813, 803.9598020099, 829.6639860856363, 829.8630725930215, 831.8752187171912, 609.0985341694274, 609.1259043272918, 609.2627920216544, 609.3327806052365, 609.5093449772932, 13951.58145255644, 13975.231362275072, 13984.300784960813, 13998.370073346723, 14004.089734167246, 13976.860231397657, 14074.648133796634, 14242.501512447117, 14313.57059288223, 14517.491887783983, 10545.525451354708, 10872.67381978542, 10963.0, 11023.393713345762, 11076.944615276872, 4416.6025057744955, 4498.572635599613, 4570.337301091323, 4591.586757191869, 4670.509596492353, 74338.0, 78050.0, 78303.0, 78492.0, 79389.20610793933, 10726.839097413545, 10855.728606784736, 11261.71845703864, 11274.718132046764, 11461.54153833854, 21128.683069753966, 21472.24847130343, 21610.0, 21611.459713507287, 21618.243361482273, 8077.192280771993, 8142.592870356577, 8221.17788221173, 8412.242898139197, 8461.873071903927, 4710.105080034782, 4737.8341758038305, 4737.857864264078, 4742.762861856893, 4881.609471242292, 3412.8805491807666, 3461.498082777983, 3534.9823250883583, 3535.6994655454573, 3536.550014494045, 506.344284152024, 600.6006006005957, 600.8287638023143, 605.6608299352289, 620.5501011766434, 735.8381156145639, 759.9696012159562, 764.9502782319131, 770.3490550484831, 792.057506363861, 10130.848037279447, 10415.958404159675, 10504.264701470824, 10610.787784244427, 10653.946730266454, 638.9712462939179, 678.0507289794228, 727.788941207044, 730.0655161393424, 752.2778132992279, 4703.17694403478, 4728.976355118202, 4747.643926705511, 4751.263554149113, 4769.904601907942, 73190.0, 73917.2608273921, 74222.6288868563, 74694.25305746982, 75102.62448687722, 81200.59399702963, 113629.0, 114455.0, 114555.42722286502, 115445.0, 99627.00372996322, 100142.49928750456, 100253.0, 100574.49712751535, 103968.0, 8755.299576033774, 9044.186023257938, 9424.528773561431, 9613.327067105236, 9860.506974651382, 48610.270845938045, 51302.74348628233, 52636.47363526469, 52924.735376322875, 53328.4667153339, 76572.61713691396, 77227.61386193258, 78402.21597784177, 79366.6031669838, 79686.4062718754, 13302.933485332898, 13462.192268463923, 13850.16898986064, 13913.234772087633, 14001.5099471518, 15060.246987650355, 15296.0, 15348.462803801813, 15386.846131538541, 15958.441454549034, 14284.142951422948, 14575.0, 14882.18148001827, 14944.252787360805, 15140.545783626509, 13904.37430315618, 14216.644583885485, 14330.49843255481, 14927.179005154821, 15164.469243576423, 12926.741465170831, 13059.542915997894, 14065.507707230197, 14590.635234118807, 14759.262036898326, 10837.403942782907, 11043.337399756041, 11258.887411126112, 11351.21895135697, 11406.885931140583, 10873.673789786002, 10963.451827408757, 10989.61536346224, 11122.666320010412, 11132.276402033842], "value": 7552.756719468872, "unit": "score"}], "name": "dromaeo_css", "value": 7178.692553229849, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 109.0, 110.0, 112.0, 111.0, 112.0, 114.0, 111.0, 113.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 119.0, 120.0, 180.0, 118.0, 116.0, 149.0, 123.0, 162.0, 118.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 160.0, 159.0, 160.0, 162.0, 160.0, 162.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 122.0, 76.0, 76.0, 74.0, 74.0, 101.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 118.0, 84.0, 84.0, 84.0, 116.0, 84.0, 84.0, 120.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 53.0, 52.0, 53.0, 54.0, 53.0, 54.0, 54.0, 63.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0, 59.0, 59.0, 60.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 77.0, 81.0, 78.0, 87.0, 74.0, 75.0, 83.0, 74.0, 85.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 129.0, 118.0, 118.0, 122.0, 120.0, 159.0, 119.0], "value": 123.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 156.0, 155.0, 158.0, 154.0, 159.0, 154.0, 154.0, 156.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 66.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 60.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1477.5999999999997, "alertThreshold": 2.0}]} 09:31:53 INFO - Return code: 0 09:31:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:31:53 INFO - # TBPL SUCCESS # 09:31:53 INFO - Running post-action listener: _resource_record_post_action 09:31:53 INFO - ##### 09:31:53 INFO - ##### Finished run-tests step (success) 09:31:53 INFO - ##### 09:31:53 INFO - Running post-run listener: _resource_record_post_run 09:31:53 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552521728; Read time: 8; Write time: 418876 09:31:53 INFO - TinderboxPrint: CPU usage
13.0% 09:31:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 09:31:53 INFO - TinderboxPrint: I/O write bytes / time
552,521,728 / 418,876 09:31:53 INFO - TinderboxPrint: CPU idle
8,271.8 (87.0%) 09:31:53 INFO - TinderboxPrint: CPU user
1,193.1 (12.6%) 09:31:53 INFO - TinderboxPrint: Swap in / out
0 / 0 09:31:53 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256196608; Read time: 0; Write time: 221904 09:31:53 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 295710720; Read time: 0; Write time: 196972 09:31:54 INFO - Running post-run listener: _upload_blobber_files 09:31:54 INFO - Blob upload gear active. 09:31:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:31:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:31:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:31:54 INFO - (blobuploader) - INFO - Open directory for files ... 09:31:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:31:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:31:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:55 INFO - (blobuploader) - INFO - Done attempting. 09:31:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:31:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:31:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:58 INFO - (blobuploader) - INFO - Done attempting. 09:31:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:31:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:31:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:59 INFO - (blobuploader) - INFO - Done attempting. 09:31:59 INFO - (blobuploader) - INFO - Iteration through files over. 09:31:59 INFO - Return code: 0 09:31:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:31:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:31:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f46768ef64c3187e4542e5b3c239f1707c12963b61c29e734d23a6d2d5571dec32ac9c17985f60e08954e7606c46057a17572ba854770de40d9830e80977e08c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/451bb0cbebe35d5ad5cf7588e0e09bc159179cc220a7c0342bad8d3cadda2f3ba838ac0d9907682416c053a96c7d994c3ff40887d6edc67374f1a351fc61e682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/46f8963674513bc0a9b9498550a1b8b19434bcd1bb91949d842eaad121f54124f79f43f494cee6d9007c40c7f3f8115bb6dd25402d8563df4ae9ed380491ea56"} 09:31:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:31:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:31:59 INFO - Contents: 09:31:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f46768ef64c3187e4542e5b3c239f1707c12963b61c29e734d23a6d2d5571dec32ac9c17985f60e08954e7606c46057a17572ba854770de40d9830e80977e08c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/451bb0cbebe35d5ad5cf7588e0e09bc159179cc220a7c0342bad8d3cadda2f3ba838ac0d9907682416c053a96c7d994c3ff40887d6edc67374f1a351fc61e682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/46f8963674513bc0a9b9498550a1b8b19434bcd1bb91949d842eaad121f54124f79f43f494cee6d9007c40c7f3f8115bb6dd25402d8563df4ae9ed380491ea56"} 09:31:59 INFO - Running post-run listener: copy_logs_to_upload_dir 09:31:59 INFO - Copying logs to upload dir... 09:31:59 INFO - mkdir: /builds/slave/test/build/upload/logs 09:31:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.463304 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-08 09:31:59.484773) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 09:31:59.488764) ========= 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=6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f46768ef64c3187e4542e5b3c239f1707c12963b61c29e734d23a6d2d5571dec32ac9c17985f60e08954e7606c46057a17572ba854770de40d9830e80977e08c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/451bb0cbebe35d5ad5cf7588e0e09bc159179cc220a7c0342bad8d3cadda2f3ba838ac0d9907682416c053a96c7d994c3ff40887d6edc67374f1a351fc61e682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/46f8963674513bc0a9b9498550a1b8b19434bcd1bb91949d842eaad121f54124f79f43f494cee6d9007c40c7f3f8115bb6dd25402d8563df4ae9ed380491ea56"} build_url:https://queue.taskcluster.net/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011399 build_url: 'https://queue.taskcluster.net/v1/task/HDt0cCu6RceWr2ZKmDSwOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f46768ef64c3187e4542e5b3c239f1707c12963b61c29e734d23a6d2d5571dec32ac9c17985f60e08954e7606c46057a17572ba854770de40d9830e80977e08c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/451bb0cbebe35d5ad5cf7588e0e09bc159179cc220a7c0342bad8d3cadda2f3ba838ac0d9907682416c053a96c7d994c3ff40887d6edc67374f1a351fc61e682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/46f8963674513bc0a9b9498550a1b8b19434bcd1bb91949d842eaad121f54124f79f43f494cee6d9007c40c7f3f8115bb6dd25402d8563df4ae9ed380491ea56"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 09:31:59.514480) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 09:31:59.514824) ========= 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=6dbc10da6d83fee962c624be000001a8-1467993170.448779-2073586921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004375 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 09:31:59.598262) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 09:31:59.598583) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 09:31:59.598885) ========= ========= Total master_lag: 0.17 =========