builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1467231434.02 results: success (0) buildid: 20160629120130 builduid: 4510152dfc4e45be8a562c26817cd09f revision: 5ecfdfb4a997766e51465fadc7453097a830b372 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 13:17:14.020074) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 13:17:14.020546) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 13:17:14.020829) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 13:17:14.035802) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:17:14.036179) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 13:17:14-- 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% 89.0M=0s 2016-06-29 13:17:14 (89.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080124 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:17:14.131058) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:17:14.131394) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020563 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:17:14.181473) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:17:14.181842) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5ecfdfb4a997766e51465fadc7453097a830b372 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5ecfdfb4a997766e51465fadc7453097a830b372 --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=14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 13:17:14,294 truncating revision to first 12 chars 2016-06-29 13:17:14,294 Setting DEBUG logging. 2016-06-29 13:17:14,294 attempt 1/10 2016-06-29 13:17:14,295 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5ecfdfb4a997?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 13:17:14,649 unpacking tar archive at: fx-team-5ecfdfb4a997/testing/mozharness/ program finished with exit code 0 elapsedTime=0.696237 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:17:14.892215) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 13:17:14.892583) ========= script_repo_revision: 5ecfdfb4a997766e51465fadc7453097a830b372 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 13:17:14.893002) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 13:17:14.893274) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 13:17:14.903048) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-29 13:17:14.903474) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:17:15 INFO - MultiFileLogger online at 20160629 13:17:15 in /builds/slave/test 13:17:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:17:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:17:15 INFO - {'append_to_log': False, 13:17:15 INFO - 'base_work_dir': '/builds/slave/test', 13:17:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:17:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:17:15 INFO - 'branch': 'Fx-Team-Non-PGO', 13:17:15 INFO - 'buildbot_json_path': 'buildprops.json', 13:17:15 INFO - 'config_files': ('talos/linux_config.py',), 13:17:15 INFO - 'default_actions': ('clobber', 13:17:15 INFO - 'read-buildbot-config', 13:17:15 INFO - 'download-and-extract', 13:17:15 INFO - 'populate-webroot', 13:17:15 INFO - 'create-virtualenv', 13:17:15 INFO - 'install', 13:17:15 INFO - 'run-tests'), 13:17:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:17:15 INFO - 'download_minidump_stackwalk': True, 13:17:15 INFO - 'download_symbols': 'ondemand', 13:17:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:17:15 INFO - 'tooltool.py': '/tools/tooltool.py', 13:17:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:17:15 INFO - '/tools/misc-python/virtualenv.py')}, 13:17:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:17:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:17:15 INFO - 'installer_path': 'installer.exe', 13:17:15 INFO - 'log_level': 'info', 13:17:15 INFO - 'log_name': 'talos', 13:17:15 INFO - 'log_to_console': True, 13:17:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:17:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:17:15 INFO - 'opt_config_files': (), 13:17:15 INFO - 'pip_index': False, 13:17:15 INFO - 'sps_profile': False, 13:17:15 INFO - 'sps_profile_interval': 0, 13:17:15 INFO - 'suite': 'dromaeojs', 13:17:15 INFO - 'system_bits': '32', 13:17:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:17:15 INFO - 'title': 'talos-linux64-ix-036', 13:17:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:17:15 INFO - 'use_talos_json': True, 13:17:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:17:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:17:15 INFO - 'work_dir': 'build'} 13:17:15 INFO - ##### 13:17:15 INFO - ##### Running clobber step. 13:17:15 INFO - ##### 13:17:15 INFO - Running pre-action listener: _resource_record_pre_action 13:17:15 INFO - Running main action method: clobber 13:17:15 INFO - rmtree: /builds/slave/test/build 13:17:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:17:15 INFO - Running post-action listener: _resource_record_post_action 13:17:15 INFO - ##### 13:17:15 INFO - ##### Finished clobber step (success) 13:17:15 INFO - ##### 13:17:15 INFO - ##### 13:17:15 INFO - ##### Running read-buildbot-config step. 13:17:15 INFO - ##### 13:17:15 INFO - Running pre-action listener: _resource_record_pre_action 13:17:15 INFO - Running main action method: read_buildbot_config 13:17:15 INFO - Using buildbot properties: 13:17:15 INFO - { 13:17:15 INFO - "project": "", 13:17:15 INFO - "product": "firefox", 13:17:15 INFO - "script_repo_revision": "production", 13:17:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:17:15 INFO - "repository": "", 13:17:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:17:15 INFO - "buildid": "20160629120130", 13:17:15 INFO - "pgo_build": "False", 13:17:15 INFO - "basedir": "/builds/slave/test", 13:17:15 INFO - "buildnumber": 1908, 13:17:15 INFO - "slavename": "talos-linux64-ix-036", 13:17:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:17:15 INFO - "platform": "ubuntu64_hw", 13:17:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:17:15 INFO - "branch": "fx-team", 13:17:15 INFO - "repo_path": "integration/fx-team", 13:17:15 INFO - "revision": "5ecfdfb4a997766e51465fadc7453097a830b372", 13:17:15 INFO - "stage_platform": "linux64", 13:17:15 INFO - "builduid": "4510152dfc4e45be8a562c26817cd09f", 13:17:15 INFO - "slavebuilddir": "test" 13:17:15 INFO - } 13:17:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:17:15 INFO - Running post-action listener: _resource_record_post_action 13:17:15 INFO - ##### 13:17:15 INFO - ##### Finished read-buildbot-config step (success) 13:17:15 INFO - ##### 13:17:15 INFO - ##### 13:17:15 INFO - ##### Running download-and-extract step. 13:17:15 INFO - ##### 13:17:15 INFO - Running pre-action listener: _resource_record_pre_action 13:17:15 INFO - Running main action method: download_and_extract 13:17:15 INFO - mkdir: /builds/slave/test/build/tests 13:17:15 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')]} 13:17:15 INFO - https://queue.taskcluster.net/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:17:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:17:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:17:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/co3RKOIIRum4aFGuj56pmQ/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 13:17:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/co3RKOIIRum4aFGuj56pmQ/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 13:17:16 INFO - Downloaded 1361 bytes. 13:17:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:17:16 INFO - Using the following test package requirements: 13:17:16 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:17:16 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:17:16 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:17:16 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:16 INFO - u'jsshell-linux-x86_64.zip'], 13:17:16 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:17:16 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:17:16 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:17:16 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:17:16 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:17:16 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:17:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:17:16 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')]} 13:17:16 INFO - https://queue.taskcluster.net/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:17:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:17:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:17:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/co3RKOIIRum4aFGuj56pmQ/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 13:17:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/co3RKOIIRum4aFGuj56pmQ/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 13:17:17 INFO - Downloaded 22701715 bytes. 13:17:17 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'] 13:17:17 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 13:17:18 INFO - Return code: 0 13:17:18 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 13:17:18 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')]} 13:17:18 INFO - https://queue.taskcluster.net/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:17:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:17:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:17:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/co3RKOIIRum4aFGuj56pmQ/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 13:17:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/co3RKOIIRum4aFGuj56pmQ/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 13:17:19 INFO - Downloaded 22701715 bytes. 13:17:19 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'] 13:17:19 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 13:17:21 INFO - Return code: 0 13:17:21 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')]} 13:17:21 INFO - https://queue.taskcluster.net/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:17:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:17:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:17:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/co3RKOIIRum4aFGuj56pmQ/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 13:17:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/co3RKOIIRum4aFGuj56pmQ/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 13:17:22 INFO - Downloaded 14405245 bytes. 13:17:22 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'] 13:17:22 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 13:17:22 INFO - Return code: 0 13:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:22 INFO - https://queue.taskcluster.net/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:17:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:17:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:17:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/co3RKOIIRum4aFGuj56pmQ/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 13:17:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/co3RKOIIRum4aFGuj56pmQ/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 13:17:24 INFO - Downloaded 56468958 bytes. 13:17:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:17:24 INFO - mkdir: /builds/slave/test/properties 13:17:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:17:24 INFO - Writing to file /builds/slave/test/properties/build_url 13:17:24 INFO - Contents: 13:17:24 INFO - build_url:https://queue.taskcluster.net/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:17:25 INFO - Running post-action listener: _resource_record_post_action 13:17:25 INFO - Running post-action listener: set_extra_try_arguments 13:17:25 INFO - ##### 13:17:25 INFO - ##### Finished download-and-extract step (success) 13:17:25 INFO - ##### 13:17:25 INFO - ##### 13:17:25 INFO - ##### Running populate-webroot step. 13:17:25 INFO - ##### 13:17:25 INFO - Running pre-action listener: _resource_record_pre_action 13:17:25 INFO - Running main action method: populate_webroot 13:17:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:17:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:17:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:17:25 INFO - '--tppagecycles', 13:17:25 INFO - '7'], 13:17:25 INFO - 'tests': ['tsvgm']}}, 13:17:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:17:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:17:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:17:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:17:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:17:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:17:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:25 INFO - 'talos_options': ['--disable-e10s'], 13:17:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:17:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:17:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:25 INFO - 'talos_options': ['--disable-e10s'], 13:17:25 INFO - 'tests': ['damp', 'tps']}, 13:17:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:25 INFO - 'tests': ['damp', 'tps']}, 13:17:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:17:25 INFO - 'tests': ['dromaeo_dom']}, 13:17:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:17:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:17:25 INFO - 'tests': ['basic_compositor_video']}, 13:17:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:17:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:17:25 INFO - 'tests': ['a11yr', 13:17:25 INFO - 'ts_paint', 13:17:25 INFO - 'tpaint', 13:17:25 INFO - 'sessionrestore', 13:17:25 INFO - 'sessionrestore_no_auto_restore', 13:17:25 INFO - 'tabpaint']}, 13:17:25 INFO - 'other-e10s': {'tests': ['a11yr', 13:17:25 INFO - 'ts_paint', 13:17:25 INFO - 'tpaint', 13:17:25 INFO - 'sessionrestore', 13:17:25 INFO - 'sessionrestore_no_auto_restore', 13:17:25 INFO - 'tabpaint']}, 13:17:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:17:25 INFO - 'ts_paint', 13:17:25 INFO - 'tpaint', 13:17:25 INFO - 'sessionrestore', 13:17:25 INFO - 'sessionrestore_no_auto_restore', 13:17:25 INFO - 'tabpaint']}, 13:17:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:17:25 INFO - 'ts_paint', 13:17:25 INFO - 'tpaint', 13:17:25 INFO - 'sessionrestore', 13:17:25 INFO - 'sessionrestore_no_auto_restore', 13:17:25 INFO - 'tabpaint']}, 13:17:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:17:25 INFO - 'tests': ['a11yr', 13:17:25 INFO - 'ts_paint', 13:17:25 INFO - 'tpaint', 13:17:25 INFO - 'sessionrestore', 13:17:25 INFO - 'sessionrestore_no_auto_restore', 13:17:25 INFO - 'tabpaint']}, 13:17:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:17:25 INFO - 'tests': ['a11yr', 13:17:25 INFO - 'ts_paint', 13:17:25 INFO - 'tpaint', 13:17:25 INFO - 'sessionrestore', 13:17:25 INFO - 'sessionrestore_no_auto_restore', 13:17:25 INFO - 'tabpaint']}, 13:17:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:17:25 INFO - 'tests': ['tsvgx', 13:17:25 INFO - 'tsvgr_opacity', 13:17:25 INFO - 'tart', 13:17:25 INFO - 'tscrollx', 13:17:25 INFO - 'cart']}, 13:17:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:17:25 INFO - 'tsvgr_opacity', 13:17:25 INFO - 'tart', 13:17:25 INFO - 'tscrollx', 13:17:25 INFO - 'cart']}, 13:17:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:25 INFO - 'talos_options': ['--disable-e10s'], 13:17:25 INFO - 'tests': ['tp5o']}, 13:17:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:25 INFO - 'tests': ['tp5o']}, 13:17:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:25 INFO - 'talos_options': ['--disable-e10s', 13:17:25 INFO - '--xperf_path', 13:17:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:17:25 INFO - 'tests': ['tp5n']}, 13:17:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:25 INFO - 'talos_options': ['--xperf_path', 13:17:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:17:25 INFO - 'tests': ['tp5n']}}, 13:17:25 INFO - 'talos.zip': {'path': '', 13:17:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:17:25 INFO - Running post-action listener: _resource_record_post_action 13:17:25 INFO - ##### 13:17:25 INFO - ##### Finished populate-webroot step (success) 13:17:25 INFO - ##### 13:17:25 INFO - ##### 13:17:25 INFO - ##### Running create-virtualenv step. 13:17:25 INFO - ##### 13:17:25 INFO - Running pre-action listener: _resource_record_pre_action 13:17:25 INFO - Running main action method: create_virtualenv 13:17:25 INFO - Creating virtualenv /builds/slave/test/build/venv 13:17:25 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 13:17:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:17:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:17:25 INFO - Using real prefix '/usr' 13:17:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:17:25 INFO - Installing distribute.............................................................................................................................................................................................done. 13:17:27 INFO - Installing pip.................done. 13:17:27 INFO - Return code: 0 13:17:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf53b0>, '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 0x1cf62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180', '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 13:17:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:17:27 INFO - Using env: {'DISPLAY': ':0', 13:17:27 INFO - 'HOME': '/home/cltbld', 13:17:27 INFO - 'LANG': 'en_US.UTF-8', 13:17:27 INFO - 'LANGUAGE': 'en_US:en', 13:17:27 INFO - 'LOGNAME': 'cltbld', 13:17:27 INFO - 'MAIL': '/var/mail/cltbld', 13:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:27 INFO - 'MOZ_NO_REMOTE': '1', 13:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:27 INFO - 'NO_EM_RESTART': '1', 13:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:27 INFO - 'PWD': '/builds/slave/test', 13:17:27 INFO - 'SHELL': '/bin/bash', 13:17:27 INFO - 'SHLVL': '1', 13:17:27 INFO - 'TERM': 'linux', 13:17:27 INFO - 'TMOUT': '86400', 13:17:27 INFO - 'USER': 'cltbld', 13:17:27 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180', 13:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:27 INFO - '_': '/tools/buildbot/bin/python'} 13:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:27 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 13:17:27 INFO - Cleaning up... 13:17:27 INFO - Return code: 0 13:17:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf53b0>, '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 0x1cf62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180', '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 13:17:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:17:27 INFO - Using env: {'DISPLAY': ':0', 13:17:27 INFO - 'HOME': '/home/cltbld', 13:17:27 INFO - 'LANG': 'en_US.UTF-8', 13:17:27 INFO - 'LANGUAGE': 'en_US:en', 13:17:27 INFO - 'LOGNAME': 'cltbld', 13:17:27 INFO - 'MAIL': '/var/mail/cltbld', 13:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:27 INFO - 'MOZ_NO_REMOTE': '1', 13:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:27 INFO - 'NO_EM_RESTART': '1', 13:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:27 INFO - 'PWD': '/builds/slave/test', 13:17:27 INFO - 'SHELL': '/bin/bash', 13:17:27 INFO - 'SHLVL': '1', 13:17:27 INFO - 'TERM': 'linux', 13:17:27 INFO - 'TMOUT': '86400', 13:17:27 INFO - 'USER': 'cltbld', 13:17:27 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180', 13:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:27 INFO - '_': '/tools/buildbot/bin/python'} 13:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:28 INFO - Downloading/unpacking psutil>=3.1.1 13:17:28 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 13:17:28 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 13:17:28 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 13:17:28 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 13:17:28 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 13:17:28 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 13:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:17:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:17:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:17:30 INFO - Installing collected packages: psutil 13:17:30 INFO - Running setup.py install for psutil 13:17:30 INFO - building 'psutil._psutil_linux' extension 13:17:30 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 13:17:30 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 13:17:30 INFO - building 'psutil._psutil_posix' extension 13:17:30 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 13:17:30 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 13:17:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:17:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:17:30 INFO - Successfully installed psutil 13:17:30 INFO - Cleaning up... 13:17:30 INFO - Return code: 0 13:17:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf53b0>, '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 0x1cf62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180', '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 13:17:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:17:30 INFO - Using env: {'DISPLAY': ':0', 13:17:30 INFO - 'HOME': '/home/cltbld', 13:17:30 INFO - 'LANG': 'en_US.UTF-8', 13:17:30 INFO - 'LANGUAGE': 'en_US:en', 13:17:30 INFO - 'LOGNAME': 'cltbld', 13:17:30 INFO - 'MAIL': '/var/mail/cltbld', 13:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:30 INFO - 'MOZ_NO_REMOTE': '1', 13:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:30 INFO - 'NO_EM_RESTART': '1', 13:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:30 INFO - 'PWD': '/builds/slave/test', 13:17:30 INFO - 'SHELL': '/bin/bash', 13:17:30 INFO - 'SHLVL': '1', 13:17:30 INFO - 'TERM': 'linux', 13:17:30 INFO - 'TMOUT': '86400', 13:17:30 INFO - 'USER': 'cltbld', 13:17:30 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180', 13:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:30 INFO - '_': '/tools/buildbot/bin/python'} 13:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:17:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:17:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:17:32 INFO - Installing collected packages: mozsystemmonitor 13:17:32 INFO - Running setup.py install for mozsystemmonitor 13:17:32 INFO - Successfully installed mozsystemmonitor 13:17:32 INFO - Cleaning up... 13:17:32 INFO - Return code: 0 13:17:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:17:32 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')]} 13:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:32 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')]} 13:17:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:32 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 0x1a36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf53b0>, '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 0x1cf62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180', '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 13:17:32 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 13:17:32 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 13:17:32 INFO - Using env: {'DISPLAY': ':0', 13:17:32 INFO - 'HOME': '/home/cltbld', 13:17:32 INFO - 'LANG': 'en_US.UTF-8', 13:17:32 INFO - 'LANGUAGE': 'en_US:en', 13:17:32 INFO - 'LOGNAME': 'cltbld', 13:17:32 INFO - 'MAIL': '/var/mail/cltbld', 13:17:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:32 INFO - 'MOZ_NO_REMOTE': '1', 13:17:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:32 INFO - 'NO_EM_RESTART': '1', 13:17:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:32 INFO - 'PWD': '/builds/slave/test', 13:17:32 INFO - 'SHELL': '/bin/bash', 13:17:32 INFO - 'SHLVL': '1', 13:17:32 INFO - 'TERM': 'linux', 13:17:32 INFO - 'TMOUT': '86400', 13:17:32 INFO - 'USER': 'cltbld', 13:17:32 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180', 13:17:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:32 INFO - '_': '/tools/buildbot/bin/python'} 13:17:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:33 INFO - Downloading/unpacking jsonschema==2.5.1 13:17:33 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 13:17:33 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 13:17:33 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 13:17:33 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 13:17:33 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 13:17:33 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 13:17:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:17:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:35 INFO - Downloading functools32-3.2.3-2.tar.gz 13:17:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:17:35 INFO - warning: no files found matching '*.txt' 13:17:35 INFO - no previously-included directories found matching 'build' 13:17:35 INFO - no previously-included directories found matching 'dist' 13:17:35 INFO - no previously-included directories found matching '.git*' 13:17:35 INFO - Installing collected packages: jsonschema, functools32 13:17:35 INFO - Running setup.py install for functools32 13:17:35 INFO - warning: no files found matching '*.txt' 13:17:35 INFO - no previously-included directories found matching 'build' 13:17:35 INFO - no previously-included directories found matching 'dist' 13:17:35 INFO - no previously-included directories found matching '.git*' 13:17:35 INFO - Successfully installed jsonschema functools32 13:17:35 INFO - Cleaning up... 13:17:35 INFO - Return code: 0 13:17:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:17:35 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')]} 13:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:35 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')]} 13:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:35 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 0x1a36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf53b0>, '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 0x1cf62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180', '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 13:17:35 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 13:17:35 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 13:17:35 INFO - Using env: {'DISPLAY': ':0', 13:17:35 INFO - 'HOME': '/home/cltbld', 13:17:35 INFO - 'LANG': 'en_US.UTF-8', 13:17:35 INFO - 'LANGUAGE': 'en_US:en', 13:17:35 INFO - 'LOGNAME': 'cltbld', 13:17:35 INFO - 'MAIL': '/var/mail/cltbld', 13:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:35 INFO - 'MOZ_NO_REMOTE': '1', 13:17:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:35 INFO - 'NO_EM_RESTART': '1', 13:17:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:35 INFO - 'PWD': '/builds/slave/test', 13:17:35 INFO - 'SHELL': '/bin/bash', 13:17:35 INFO - 'SHLVL': '1', 13:17:35 INFO - 'TERM': 'linux', 13:17:35 INFO - 'TMOUT': '86400', 13:17:35 INFO - 'USER': 'cltbld', 13:17:35 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180', 13:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:35 INFO - '_': '/tools/buildbot/bin/python'} 13:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:35 INFO - Downloading/unpacking blobuploader==1.2.4 13:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:37 INFO - Downloading blobuploader-1.2.4.tar.gz 13:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:17:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:17:37 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 13:17:37 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 13:17:37 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 13:17:37 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 13:17:37 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 13:17:37 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 13:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:17:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:17:38 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 13:17:38 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 13:17:38 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 13:17:38 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 13:17:38 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 13:17:38 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 13:17:38 INFO - Downloading docopt-0.6.1.tar.gz 13:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:17:38 INFO - Installing collected packages: blobuploader, requests, docopt 13:17:38 INFO - Running setup.py install for blobuploader 13:17:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:17:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:17:38 INFO - Running setup.py install for requests 13:17:38 INFO - Running setup.py install for docopt 13:17:38 INFO - Successfully installed blobuploader requests docopt 13:17:38 INFO - Cleaning up... 13:17:39 INFO - Return code: 0 13:17:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:39 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 0x1a36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf53b0>, '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 0x1cf62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180', '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 13:17:39 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 13:17:39 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 13:17:39 INFO - Using env: {'DISPLAY': ':0', 13:17:39 INFO - 'HOME': '/home/cltbld', 13:17:39 INFO - 'LANG': 'en_US.UTF-8', 13:17:39 INFO - 'LANGUAGE': 'en_US:en', 13:17:39 INFO - 'LOGNAME': 'cltbld', 13:17:39 INFO - 'MAIL': '/var/mail/cltbld', 13:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:39 INFO - 'MOZ_NO_REMOTE': '1', 13:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:39 INFO - 'NO_EM_RESTART': '1', 13:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:39 INFO - 'PWD': '/builds/slave/test', 13:17:39 INFO - 'SHELL': '/bin/bash', 13:17:39 INFO - 'SHLVL': '1', 13:17:39 INFO - 'TERM': 'linux', 13:17:39 INFO - 'TMOUT': '86400', 13:17:39 INFO - 'USER': 'cltbld', 13:17:39 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180', 13:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:39 INFO - '_': '/tools/buildbot/bin/python'} 13:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:39 INFO - Running setup.py (path:/tmp/pip-wrvnze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:39 INFO - Running setup.py (path:/tmp/pip-NttuXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:39 INFO - Running setup.py (path:/tmp/pip-wXuqFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:39 INFO - Running setup.py (path:/tmp/pip-6ttR5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:39 INFO - Running setup.py (path:/tmp/pip-O9a2VK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:39 INFO - Running setup.py (path:/tmp/pip-DK9k1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:39 INFO - Running setup.py (path:/tmp/pip-qxlaLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:39 INFO - Running setup.py (path:/tmp/pip-ttyeXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:39 INFO - Running setup.py (path:/tmp/pip-W5I9Gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:39 INFO - Running setup.py (path:/tmp/pip-BU1B62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:39 INFO - Running setup.py (path:/tmp/pip-hv9Nez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:40 INFO - Running setup.py (path:/tmp/pip-LHMUyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:40 INFO - Running setup.py (path:/tmp/pip-BIZcnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:40 INFO - Running setup.py (path:/tmp/pip-XYzhkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:40 INFO - Running setup.py (path:/tmp/pip-T9VwWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:40 INFO - Running setup.py (path:/tmp/pip-x3x23v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:40 INFO - Running setup.py (path:/tmp/pip-0q_IjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:17:40 INFO - Running setup.py install for manifestparser 13:17:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:17:40 INFO - Running setup.py install for mozcrash 13:17:40 INFO - Running setup.py install for mozdebug 13:17:40 INFO - Running setup.py install for mozdevice 13:17:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:17:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:17:40 INFO - Running setup.py install for mozfile 13:17:40 INFO - Running setup.py install for mozhttpd 13:17:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:17:41 INFO - Running setup.py install for mozinfo 13:17:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:17:41 INFO - Running setup.py install for mozInstall 13:17:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:17:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:17:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:17:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:17:41 INFO - Running setup.py install for mozleak 13:17:41 INFO - Running setup.py install for mozlog 13:17:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:17:41 INFO - Running setup.py install for moznetwork 13:17:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:17:41 INFO - Running setup.py install for mozprocess 13:17:41 INFO - Running setup.py install for mozprofile 13:17:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:17:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:17:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:17:41 INFO - Running setup.py install for mozrunner 13:17:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:17:41 INFO - Running setup.py install for mozscreenshot 13:17:42 INFO - Running setup.py install for moztest 13:17:42 INFO - Running setup.py install for mozversion 13:17:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:17:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:17:42 INFO - Cleaning up... 13:17:42 INFO - Return code: 0 13:17:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:42 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 0x1a36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf53b0>, '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 0x1cf62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180', '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 13:17:42 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 13:17:42 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 13:17:42 INFO - Using env: {'DISPLAY': ':0', 13:17:42 INFO - 'HOME': '/home/cltbld', 13:17:42 INFO - 'LANG': 'en_US.UTF-8', 13:17:42 INFO - 'LANGUAGE': 'en_US:en', 13:17:42 INFO - 'LOGNAME': 'cltbld', 13:17:42 INFO - 'MAIL': '/var/mail/cltbld', 13:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:42 INFO - 'MOZ_NO_REMOTE': '1', 13:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:42 INFO - 'NO_EM_RESTART': '1', 13:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:42 INFO - 'PWD': '/builds/slave/test', 13:17:42 INFO - 'SHELL': '/bin/bash', 13:17:42 INFO - 'SHLVL': '1', 13:17:42 INFO - 'TERM': 'linux', 13:17:42 INFO - 'TMOUT': '86400', 13:17:42 INFO - 'USER': 'cltbld', 13:17:42 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180', 13:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:42 INFO - '_': '/tools/buildbot/bin/python'} 13:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:42 INFO - Running setup.py (path:/tmp/pip-7SaeQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:42 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)) 13:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:42 INFO - Running setup.py (path:/tmp/pip-ElMoSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:42 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)) 13:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:42 INFO - Running setup.py (path:/tmp/pip-jXVoJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:42 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)) 13:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:42 INFO - Running setup.py (path:/tmp/pip-xfWvIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:42 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)) 13:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:42 INFO - Running setup.py (path:/tmp/pip-GbdSet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:42 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)) 13:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:42 INFO - Running setup.py (path:/tmp/pip-__lTu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:42 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)) 13:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:42 INFO - Running setup.py (path:/tmp/pip-Sl_oUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:42 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)) 13:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:43 INFO - Running setup.py (path:/tmp/pip-uESbXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:43 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)) 13:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:43 INFO - Running setup.py (path:/tmp/pip-9Djhwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:43 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)) 13:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:43 INFO - Running setup.py (path:/tmp/pip-oyaHWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:43 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)) 13:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:43 INFO - Running setup.py (path:/tmp/pip-Iqffna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:43 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)) 13:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:43 INFO - Running setup.py (path:/tmp/pip-Robpee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 13:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:43 INFO - Running setup.py (path:/tmp/pip-47dDIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:43 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)) 13:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:43 INFO - Running setup.py (path:/tmp/pip-gzwdXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 13:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:43 INFO - Running setup.py (path:/tmp/pip-FiMluM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:43 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)) 13:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:43 INFO - Running setup.py (path:/tmp/pip-Lu6zsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:43 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)) 13:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:43 INFO - Running setup.py (path:/tmp/pip-YbaCBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:43 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)) 13:17:43 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)) 13:17:43 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)) 13:17:43 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)) 13:17:43 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)) 13:17:43 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)) 13:17:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17:45 INFO - Downloading blessings-1.6.tar.gz 13:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:17:45 INFO - Installing collected packages: blessings 13:17:45 INFO - Running setup.py install for blessings 13:17:45 INFO - Successfully installed blessings 13:17:45 INFO - Cleaning up... 13:17:45 INFO - Return code: 0 13:17:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:17:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:17:46 INFO - Reading from file tmpfile_stdout 13:17:46 INFO - Current package versions: 13:17:46 INFO - argparse == 1.2.1 13:17:46 INFO - blessings == 1.6 13:17:46 INFO - blobuploader == 1.2.4 13:17:46 INFO - docopt == 0.6.1 13:17:46 INFO - functools32 == 3.2.3-2 13:17:46 INFO - jsonschema == 2.5.1 13:17:46 INFO - manifestparser == 1.1 13:17:46 INFO - mozInstall == 1.12 13:17:46 INFO - mozcrash == 0.17 13:17:46 INFO - mozdebug == 0.1 13:17:46 INFO - mozdevice == 0.48 13:17:46 INFO - mozfile == 1.2 13:17:46 INFO - mozhttpd == 0.7 13:17:46 INFO - mozinfo == 0.9 13:17:46 INFO - mozleak == 0.1 13:17:46 INFO - mozlog == 3.2 13:17:46 INFO - moznetwork == 0.27 13:17:46 INFO - mozprocess == 0.22 13:17:46 INFO - mozprofile == 0.28 13:17:46 INFO - mozrunner == 6.11 13:17:46 INFO - mozscreenshot == 0.1 13:17:46 INFO - mozsystemmonitor == 0.3 13:17:46 INFO - moztest == 0.7 13:17:46 INFO - mozversion == 1.4 13:17:46 INFO - psutil == 3.1.1 13:17:46 INFO - requests == 1.2.3 13:17:46 INFO - wsgiref == 0.1.2 13:17:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17: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')]} 13:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17: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')]} 13:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:46 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 0x1a36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf53b0>, '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 0x1cf62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180', '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 13:17:46 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 13:17:46 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 13:17:46 INFO - Using env: {'DISPLAY': ':0', 13:17:46 INFO - 'HOME': '/home/cltbld', 13:17:46 INFO - 'LANG': 'en_US.UTF-8', 13:17:46 INFO - 'LANGUAGE': 'en_US:en', 13:17:46 INFO - 'LOGNAME': 'cltbld', 13:17:46 INFO - 'MAIL': '/var/mail/cltbld', 13:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:46 INFO - 'MOZ_NO_REMOTE': '1', 13:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:46 INFO - 'NO_EM_RESTART': '1', 13:17:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:46 INFO - 'PWD': '/builds/slave/test', 13:17:46 INFO - 'SHELL': '/bin/bash', 13:17:46 INFO - 'SHLVL': '1', 13:17:46 INFO - 'TERM': 'linux', 13:17:46 INFO - 'TMOUT': '86400', 13:17:46 INFO - 'USER': 'cltbld', 13:17:46 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180', 13:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:46 INFO - '_': '/tools/buildbot/bin/python'} 13:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:46 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)) 13:17:46 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)) 13:17:46 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)) 13:17:46 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)) 13:17:46 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)) 13:17:46 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)) 13:17:46 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)) 13:17:46 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)) 13:17:46 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)) 13:17:46 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)) 13:17:46 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)) 13:17:46 INFO - Cleaning up... 13:17:46 INFO - Return code: 0 13:17:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:17: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')]} 13:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17: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')]} 13:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf53b0>, '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 0x1cf62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180', '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 13:17: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', 'jsonschema'] in /builds/slave/test/build 13:17: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 jsonschema 13:17:46 INFO - Using env: {'DISPLAY': ':0', 13:17:46 INFO - 'HOME': '/home/cltbld', 13:17:46 INFO - 'LANG': 'en_US.UTF-8', 13:17:46 INFO - 'LANGUAGE': 'en_US:en', 13:17:46 INFO - 'LOGNAME': 'cltbld', 13:17:46 INFO - 'MAIL': '/var/mail/cltbld', 13:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:46 INFO - 'MOZ_NO_REMOTE': '1', 13:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:46 INFO - 'NO_EM_RESTART': '1', 13:17:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:46 INFO - 'PWD': '/builds/slave/test', 13:17:46 INFO - 'SHELL': '/bin/bash', 13:17:46 INFO - 'SHLVL': '1', 13:17:46 INFO - 'TERM': 'linux', 13:17:46 INFO - 'TMOUT': '86400', 13:17:46 INFO - 'USER': 'cltbld', 13:17:46 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180', 13:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:46 INFO - '_': '/tools/buildbot/bin/python'} 13:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:17:46 INFO - Cleaning up... 13:17:46 INFO - Return code: 0 13:17:46 INFO - Running post-action listener: _resource_record_post_action 13:17:46 INFO - Running post-action listener: _start_resource_monitoring 13:17:46 INFO - Starting resource monitoring. 13:17:46 INFO - ##### 13:17:46 INFO - ##### Finished create-virtualenv step (success) 13:17:46 INFO - ##### 13:17:46 INFO - ##### 13:17:46 INFO - ##### Running install step. 13:17:46 INFO - ##### 13:17:46 INFO - Running pre-action listener: _resource_record_pre_action 13:17:46 INFO - Running main action method: install 13:17:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:17:46 INFO - Reading from file tmpfile_stdout 13:17:46 INFO - Detecting whether we're running mozinstall >=1.0... 13:17:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:17:46 INFO - Reading from file tmpfile_stdout 13:17:46 INFO - Output received: 13:17:46 INFO - Usage: mozinstall [options] installer 13:17:46 INFO - Options: 13:17:46 INFO - -h, --help show this help message and exit 13:17:46 INFO - -d DEST, --destination=DEST 13:17:46 INFO - Directory to install application into. [default: 13:17:46 INFO - "/builds/slave/test"] 13:17:46 INFO - --app=APP Application being installed. [default: firefox] 13:17:46 INFO - mkdir: /builds/slave/test/build/application 13:17:46 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'] 13:17:46 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 13:18:03 INFO - Reading from file tmpfile_stdout 13:18:03 INFO - Output received: 13:18:03 INFO - /builds/slave/test/build/application/firefox/firefox 13:18:03 INFO - Running post-action listener: _resource_record_post_action 13:18:03 INFO - ##### 13:18:03 INFO - ##### Finished install step (success) 13:18:03 INFO - ##### 13:18:03 INFO - ##### 13:18:03 INFO - ##### Running run-tests step. 13:18:03 INFO - ##### 13:18:03 INFO - Running pre-action listener: _resource_record_pre_action 13:18:03 INFO - Running main action method: run_tests 13:18:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:18:03 INFO - Python 2.7.3 13:18:03 INFO - Return code: 0 13:18:03 INFO - grabbing minidump binary from tooltool 13:18:03 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')]} 13:18:03 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 0x1cf53b0>, '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 0x1cf62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:18:03 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 13:18:03 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 13:18:03 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 13:18:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:18:03 INFO - Return code: 0 13:18:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:18:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:18:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:18:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:18:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:18:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 13:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 13:18:03 INFO - Using env: {'DISPLAY': ':0', 13:18:03 INFO - 'HOME': '/home/cltbld', 13:18:03 INFO - 'LANG': 'en_US.UTF-8', 13:18:03 INFO - 'LANGUAGE': 'en_US:en', 13:18:03 INFO - 'LOGNAME': 'cltbld', 13:18:03 INFO - 'MAIL': '/var/mail/cltbld', 13:18:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:18:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:03 INFO - 'MOZ_NO_REMOTE': '1', 13:18:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:18:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:03 INFO - 'NO_EM_RESTART': '1', 13:18:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:03 INFO - 'PWD': '/builds/slave/test', 13:18:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:18:03 INFO - 'SHELL': '/bin/bash', 13:18:03 INFO - 'SHLVL': '1', 13:18:03 INFO - 'TERM': 'linux', 13:18:03 INFO - 'TMOUT': '86400', 13:18:03 INFO - 'USER': 'cltbld', 13:18:03 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180', 13:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:03 INFO - '_': '/tools/buildbot/bin/python'} 13:18:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 13:18:03 INFO - mozversion application_buildid: 20160629120130 13:18:03 INFO - mozversion application_changeset: 5ecfdfb4a997766e51465fadc7453097a830b372 13:18:03 INFO - mozversion application_display_name: Nightly 13:18:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:18:03 INFO - mozversion application_name: Firefox 13:18:03 INFO - mozversion application_remotingname: firefox 13:18:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:18:03 INFO - mozversion application_vendor: Mozilla 13:18:03 INFO - mozversion application_version: 50.0a1 13:18:03 INFO - mozversion platform_buildid: 20160629120130 13:18:03 INFO - mozversion platform_changeset: 5ecfdfb4a997766e51465fadc7453097a830b372 13:18:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:18:03 INFO - mozversion platform_version: 50.0a1 13:18:03 INFO - using testdate: 1467231483 13:18:03 INFO - actual date: 1467231483 13:18:03 INFO - starting webserver on 'localhost:32950' 13:18:03 INFO - SUITE-START | Running 2 tests 13:18:03 INFO - TEST-START | dromaeo_css 13:18:03 INFO - operating with platform_type : linux_ 13:18:03 INFO - Initialising browser for dromaeo_css test... 13:18:03 INFO - TEST-INFO | started process 6112 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWFCFm9/profile http://localhost:32950/getInfo.html) 13:18:07 INFO - PROCESS | 6112 | __metrics Screen width/height:1600/1200 13:18:07 INFO - PROCESS | 6112 | colorDepth:24 13:18:07 INFO - PROCESS | 6112 | Browser inner width/height: 1024/697 13:18:07 INFO - PROCESS | 6112 | __metrics 13:18:08 INFO - PROCESS | 6112 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:18:09 INFO - TEST-INFO | 6112: exit 0 13:18:09 INFO - Browser initialized. 13:18:09 INFO - Running cycle 1/1 for dromaeo_css test... 13:18:09 INFO - TEST-INFO | started process 6196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWFCFm9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:18:21 INFO - PROCESS | 6196 | RSS: Main: 158920704 13:18:21 INFO - PROCESS | 6196 | 13:19:12 INFO - PROCESS | 6196 | 1467231552590 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] 13:21:25 INFO - PROCESS | 6196 | Cycle 1(1): loaded http://localhost:32950/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32950/tests/dromaeo/cssquery-ext.html) 13:21:27 INFO - PROCESS | 6196 | RSS: Main: 268914688 13:21:27 INFO - PROCESS | 6196 | 13:24:29 INFO - PROCESS | 6196 | Cycle 1(1): loaded http://localhost:32950/tests/dromaeo/cssquery-ext.html (next: http://localhost:32950/tests/dromaeo/cssquery-jquery.html) 13:24:30 INFO - PROCESS | 6196 | RSS: Main: 241315840 13:24:30 INFO - PROCESS | 6196 | 13:27:32 INFO - PROCESS | 6196 | Cycle 1(1): loaded http://localhost:32950/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32950/tests/dromaeo/cssquery-mootools.html) 13:27:33 INFO - PROCESS | 6196 | RSS: Main: 236077056 13:27:33 INFO - PROCESS | 6196 | 13:30:35 INFO - PROCESS | 6196 | Cycle 1(1): loaded http://localhost:32950/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32950/tests/dromaeo/cssquery-prototype.html) 13:30:35 INFO - PROCESS | 6196 | RSS: Main: 241713152 13:30:35 INFO - PROCESS | 6196 | 13:33:39 INFO - PROCESS | 6196 | Cycle 1(1): loaded http://localhost:32950/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32950/tests/dromaeo/cssquery-yui.html) 13:33:39 INFO - PROCESS | 6196 | RSS: Main: 218005504 13:33:39 INFO - PROCESS | 6196 | 13:36:42 INFO - PROCESS | 6196 | Cycle 1(1): loaded http://localhost:32950/tests/dromaeo/cssquery-yui.html (next: http://localhost:32950/tests/dromaeo/cssquery-dojo.html) 13:36:42 INFO - PROCESS | 6196 | RSS: Main: 264130560 13:36:42 INFO - PROCESS | 6196 | 13:36:42 INFO - PROCESS | 6196 | __start_tp_report 13:36:42 INFO - PROCESS | 6196 | _x_x_mozilla_page_load 13:36:42 INFO - PROCESS | 6196 | _x_x_mozilla_page_load_details 13:36:42 INFO - PROCESS | 6196 | |i|pagename|runs| 13:36:42 INFO - PROCESS | 6196 | |0;dojo.html;2651.1516314779274;2669.3059804450836;2691.703912569617;2710.3359676879154;2710.5934109883515;4722.551357621029;4795.184818580841;4824.831130910419;4826.324314595955;4860.319555262262;4804.807807687688;4805.087033463639;4834.854954351375;4855.465898751135;4873.926891096637;4299.44107266055;4307.870763877073;4364.49808272048;4480.2607569751035;4503.504614492404;4354.716943398669;4422;4447.421835161441;4485.932711009337;4520.434945631796;4452.888677783049;4485.058137791068;4506.436695413074;4510.639148868099;4525.909481810362;4278.871633850989;4297.226499230137;4303.289957157065;4318.4170137031415;4322.805473753689;4278.2085314216965;4301.096769678371;4331.675124365654;4331.805068771912;4347.456567929009;4760.7619619018915;4767.642426818003;4786.952130478686;4793.544613261734;4799.352087468217;4881.365422495089;4962.900741985176;5045.318881950926;5061.519155680205;5074.771635276385;5085.923711144335;5142.74286285688;5154.9484505155215;5158.535731784157;5168.715720635363;4675.29870519418;4795.304680821261;4797.95202047982;4798.256270278147;4799.976000120047;5312;5362.27609272751;5363.624546281723;5363.892722145613;5427.647202931876;5162.586993040548;5204.713740744295;5207.1668533034535;5209.29674493946;5211.114110601206;5002.274670172805;5075.3148324975655;5280.471952804765;5289.894202115936;5291.285676433632;5056.443791182967;5073.797048118107;5097.770600322994;5102.464241254689;5141.126008578551;5060.291559181717;5068.189089745623;5075.137226671474;5088.313077734459;5124.359455068116;4255.276602977501;4280.101178752435;4312.956870431255;4387.078713470143;4429.80065897029;3821.9426708599394;3831.7509361891944;3841.5006049213425;3889.5138107736534;3905.5703872573995;4445;4452.443444569429;4458.9554104459185;4499.347594598765;4500.099980004013;5038.118329292359;5057.393112826484;5076.923846142311;5223.451537588575;5291.682499050069;4375.290246228638;4386.144701783185;4393.802278897458;4438.889027774267;4445.977425192224;4586;4595.356650068993;4597.494275629678;4605.884852878705;4645.860624181212;4732.929006064843;4839.975800120977;4846.684965477232;4854.635902307412;4896.094222568836;5192.42883282831;5212.582993360598;5226.503482169188;5237.895242095213;5267.815626453055;4871.391076115486;4894.804207831647;4919.778609962632;4920.065187614342;4953.72754498506;4945.826896058621;4996.2505624156665;5042.84871453857;5057.620678449204;5112.846614601568;5114.284000239895;5125.469294549993;5137.17805151174;5138.768755405941;5139.357580302462;4964.751762411793;4984.601231901512;4988.226824842155;5006.624503162205;5034.018366418513;4841.370621819282;4955.331030311006;4971.950280497149;5003.049420610072;5027.84916452507;4877.512248775094;4916.360873086619;4919.901601968012;4966.205407134841;4974.875628109182;4889.584385327287;5034.2951986721155;5048;5050.898982020412;5051.393832740095;4815.7351345676325;4819.2530157825595;4863.173260545786;4880.536349046835;4927.655064145475 13:36:42 INFO - PROCESS | 6196 | |1;ext.html;578.8321386797829;587.9353271140174;595.5890435599439;597.742970522675;603.381533927724;27458.31354216143;39304.2139157217;40531;40573.59426405735;43927.3410898836;41016.38475422864;41365.37951930716;41461.37807932876;41467;41468.792656036756;7816.726414575491;7955.96022019892;7966.4025198110085;7966.880496792553;7971.760847174565;7840.098388685288;7897.328727058207;7932.643031063587;7934;7936.285734283913;7917.327027202695;7960.880586791202;7966.4025198110085;7971.920280797205;7975.60121993898;7894.3289820365335;7913.723019694283;7935.047794264668;7938.24586664266;7944.2055794420385;7870.763877083639;7946;7951.04587449504;7956;7958.045034595828;38921.805390973146;39221;39224.803875980724;39253.80373098116;39291.8035409824;2807.83153010818;2812.493751124817;2868.6127372804613;2875.1087162979543;2905.186547766629;28326.716732832614;29007.274818129503;29124.41751164986;29749.70250297491;30237.69762302371;3355.832208389595;3362.231661346781;3413.5562376890844;3421.275499843984;3457.6888080072913;249495;249579;251004;251336;251444;32163.356732865213;52268.21597676038;52503.737481312346;52542;52546;32096.839515802272;34110.829445852614;34299.82850085734;34396.31207375838;34431.48352774711;13794.310284485735;13997.34050530396;14161.78757318641;14167.716645667235;14177.14937103777;11332.263402878787;11365;11485.770284594428;11489.597864074718;11507.19449638534;7911.496815605016;7918.28735413804;7958;7981.082175549886;8013.11855695873;3114.6885311468673;3129.0925631567047;3156.6899736609507;3159.0996565978585;3191.760617953663;794.8767940969159;833.3541505333294;895.713371721043;901.4320977784085;927.8515437529962;28039;28178.85910570475;28749.712502874703;29256.26859328534;29306.706932930825;784.4587234807964;942.6323733743845;943.165298710646;950.092661508258;985.2856678907734;14357.56927292183;14680.265986700835;14713.264336783119;14779.482718104815;14816.185109818847;380747;384375;384409;385056;387221;46860.531394686295;48454.51545484571;48487.75756121197;48497.272540911916;48603.27095093577;1085.907697845692;1164.9301041937342;1166.2361153444508;1182.692499950002;1198.2151690642643;27883.44233115367;28614;29352.55971160477;29860.850695746383;29887.850560747058;41701.79149104235;42128;42217.36673949832;42229.57770422257;42258.57741422547;304424;307161;307874;308515;378231;25139.622905656062;25526.744732552437;25767.484650307262;27124.1862744118;27154.1853744388;41818.96804528962;42329;42654.36018459663;43091;43165;36696.0825979342;36781.816090919376;37175.628243718296;37186;37604.435933461566;37367;37636.62363376331;37774.62225377711;37891;37982.620173797906;36378.636213637525;36800.63199368079;36938.44592331063;37541.81229093837;37646.2470750578;32064.83967580147;33421;33474.33051338911;33630.159246019044;33877.66122338745;24953;25371.112011079524;25407.237782866545;25637.74362256428;26093.869530652224 13:36:42 INFO - PROCESS | 6196 | |2;jquery.html;363.82354558039344;365.88840403676875;370.6978812268001;382.23552894211576;383.8733218038044;16486.917565412172;17630.82369176308;17952.281908723635;18003.81996180038;18027.098645067745;16007;16593.83406165938;18161.818381816178;18170.45488635343;18174.182161802717;4699.0836786826585;4894.657373983822;4916.729579873106;4920.581750551208;4921.926171107436;3501.8424170912244;3661.6338366163436;4795.592374648159;6025.698715064251;6338.366163383671;6321.841953951142;6326.462250708695;6367.172267605228;6369.267534233553;6375.394337537927;5420.159875219328;5563.721813909308;5590.524805391527;5599.468050535193;5663.178839068312;3386.542816719736;5040.445550989388;5258.027264955957;5280.867978300574;5286.682799032071;12269.202501837352;12269.57056503027;12295.754084918251;12380.690482737913;12634.49462021518;1771.2737777511288;1932.951676208092;2081.760597531288;2346.5658853112227;2373.062640257089;9303;9499.667511637059;11404.429778511125;13015.739685206243;13516.189028658213;1782.9019403932778;1786.1337251433044;1788.5439213000732;1796.8652351073722;1850.1211924335967;65885.67057164731;69159.65420172867;69715.65142174307;70100.29899700989;72097.27902720959;8456.8731469028;8796.560171991376;9125.133112354315;9219.308551858638;10143.289969702199;11972.760544789055;11997.220180688402;12011.939940300243;12080.697982550331;12080.879191207976;7210.603416812126;7362.77911662651;7378.5941773202985;7397.408207343399;7399.4450416219;7298.598577078312;7339.669714862844;7481.438892083115;7500.624968751541;7516.361109305661;3653.1415117447377;3772.4529943158636;3773.4339849022867;3803.3344164771056;3897.2595206911164;1736.2881218700525;1771.406578796092;1806.9006204658608;1829.2500074969464;1842.2170577504507;793.6507936507918;856.4475913036057;865.7013330401002;889.7330800759876;933.6312156698202;16644.50066498007;17526.21132049061;17585.20866561008;17859.28562857471;18280.45158645243;867.8958524976916;870.6169285514353;890.5814267294361;904.0778406025817;916.7433118726767;10039.72983710764;10139.188864890792;10150.543225554868;10210.081092701692;10347.844782328271;407515;411683;413196;413235;414947;75513.62243188749;75834;77945;79133;80624.19375806166;912.7763697894059;922.3727865051695;923.4736200365861;940.6331530703031;947.2847999760137;15450.381984720934;15830.604234893759;15879.841201587837;16044;16387.180640967665;37648.43527347147;37681.43477847889;37772.62227377691;38906.61093389143;39101.80449097736;45861.82457050934;51896.481035189165;52803.73598131985;53204.46795531995;54097.45902540924;7180.820479488055;7210.9278907210255;7270.636468176464;7325.633718313957;7425.183229844604;9040.547972601475;11433.256838305484;11493.655190344303;11499;11567.479463423997;9246;9304.092661004343;9404.341696081208;9569.138777510057;9810.068043535854;9742.220622350336;10065.798684026426;10111.949440252753;10115.342502737298;10140.29017968735;9431.952840235756;9508.667196648084;9740.464274464972;9793;9800.31397802147;6314.589551679126;6578.736850525926;6657.600543967377;7441.330280274801;7565.924340756742;8338.87491687613;8604.870926936226;8996.86504702443;9393.530323483936;9422.128118570787 13:36:42 INFO - PROCESS | 6196 | |3;mootools.html;1328.6213429172685;1380.2063813307348;1424.501424501424;1632.9673406531863;1653.9421120260786;7368.815779605513;7813.765587032398;7881.5271083735015;7883;7893.684252629895;6692.63190524521;7401.2598740126095;7642.770716878488;7664.386849052076;7855.332296754783;2146.259540458543;2159.373781603341;2160.481484443738;2160.8595441296343;2171.815395691368;1887.9339223127192;2107.5047363869553;2170.1427935965285;2177.3032629558547;2211.137656314039;2150.709654196687;2191.0468946008536;2202.2402271216483;2208.249195273607;2209.9668504972437;2097.8531502794885;2106.115431518766;2153.686251386653;2153.9876258158642;2154.353693891826;2113.7569179544244;2125.3836387447623;2132.41358626379;2132.978670213309;2135.519508110678;7776.533407995538;7899.210078992112;7907.525548467052;7909.881351779728;7916.525008499509;4417.249067658506;4538.160440318518;4539.205639013193;4539.659525535565;4540.137373898981;2746.7665248453904;2787.6097346371525;2839.1198728394265;2851.885924563015;2935.412917416525;915.5513798238882;943.4999450291357;949.2311227905419;957.1672644798999;959.3188835926501;10429.322094063937;10485.31845430037;10490.685279441628;10493.160547156209;10498.685039448828;3719.9814000930364;4029.6776257899296;4157.272477316457;4165.97917010413;4166.687498437629;9042.276617870555;9111.134442227978;9123.543822808833;9135.269178465707;9135.54322283883;4595.012072404449;4626.4910859805395;4629.259318509023;4631.51369106239;4635.165670179333;4094.303968325392;4177.081042170717;4210.263203939298;4213.6207741302815;4214.894627634334;3522.1370764162943;3551.982240088783;3557.217412169319;3568.4825700273836;3604.7296452766145;1070.2347821307803;1136.0797753819268;1181.710480932177;1182.6392950150287;1196.9581064662696;705.3827900586987;708.4332533972802;719.3346154806783;728.8323685552247;729.16510595368;4863.610911127102;4905.141600219948;4936;4960.677555958851;4967.552920237196;813.276184196066;819.7376839411331;831.7629475599425;847.1824689174975;872.9738107856774;3206.3266713989856;3282.7537934654997;3301.5377847101427;3312.734981201498;3360.1263671445113;9123.680671176477;9508.191803696764;9510.38182518148;9630.133288003974;9636;8352.331813454908;9413.529323533796;9508.572114254875;9522.190613797904;9524;6797.728090876409;7103.893441598277;7107.857842843217;7208.062951816335;7242.710291588278;4935.975320123376;4981.501849815135;5051.419086805065;5100.311457953278;5147.073526765069;8850.911490885266;8902.777430564287;8916.28669706409;8926.776830579287;8931.419457735226;8782;8919.955400222958;8960.86558701607;9076.909230907606;9104.544772761468;6698.028785826125;6721.059051732664;6731.1922569292;6750.932490675031;6823.55646882951;7421;7427.5914824683;7479.364254038468;7491.925080749123;7493.4379921505015;6594.307597702172;6682.46540276767;6719.395254427125;6887;7042.859142817218;6600.570962887397;6631.933680663132;6651.600903945779;6694.330566943267;6706.295838936841;6018.398160183947;6036.88317661234;6054.878902421839;6058.666773327509;6070.939290607037;4357.869263922087;4362.563743625739;4368.890777730582;4422.447194100738;4468.597826195528;4337.067530480836;4369.60673539383;4395.560443955579;4404.4494438195225;4424.225760491837 13:36:42 INFO - PROCESS | 6196 | |4;prototype.html;287.15862522808163;291.5495559360787;295.22945113254417;295.5227307897746;302.4329382407985;4846.636502262331;4896.9755151224235;4897.706137631744;4906.607471402288;4909.631777616675;4827.468978412372;4827.855164345066;4833.613310935126;4837.879053023667;4839.2499162629765;3582.7850328980344;3713.4801127842125;3714.3685573452576;3796.9810150949343;3863.343231650612;3763.435484677293;3808.5620153682403;3826.4069069294164;3829.751066180703;3843.8846834594865;3770.9622903770887;3776.622337766229;3776.678982286509;3777.3200823851835;3779.81100944953;3562.4656301554846;3599.7120230381506;3750.4186851038135;3761.567419746737;3762.7930463824478;3315.055209265372;3318.4856347266214;3319.9004029879143;3320.8173550454717;3329.96670033299;4699.788509517046;4702.247640377557;4711.575958163748;4724.6928949618505;4746.596539294164;4199.9790001050105;4279.272523670983;4309.288967320388;4314.439122914001;4332.501762297313;5011.273365362039;5034.697918124888;5038.622103342227;5040.243963405482;5048.5203905628905;3634.436662317345;3638.981805090984;3640.4903313536124;3643.890683279506;3644.5262115925025;5071.746412679388;5243.737813109329;5273.841784746425;5274.762635681365;5286.60350473716;3699.483211883115;3713.2387860488534;3721.497597824259;3726.403775395978;3729.4965179700935;3737.159139193714;3749.6625303722794;3751.531058617673;3765.8681946131755;3768.6042965488778;4248.830046798155;4251.6598672106775;4252.659787217015;4260.190563792869;4272.273713468718;4850.53919877611;4991.725455099931;5023.522765337287;5033.803534755457;5043.620774081374;1287.8132670762875;1302.8631993640531;1302.9022823288292;1309.3387839141174;1309.7707901117267;837.1126605797874;844.8425656850154;847.576211894053;878.5519385113638;919.7424721078108;4408.25059739845;4415.139047885631;4416.381706561084;4454.685867669045;4466;5137.306463627438;5143.537081662668;5144.2283657450935;5163.948360516347;5166.302549155891;4242.8727138185905;4426;4430.357598148251;4431.135928493977;4431.246688063037;2722.9319267018086;2747.162115554735;2751.5047291487726;2788.1914244868763;2790.804643674923;4930.556249937523;4944.233643785219;4945.950540494549;4963.503649635008;4963.8262660806695;5113.642045056885;5283.0942981360095;5345.38528069277;5352.5450336721815;5388.218708287276;4954.281629163823;4973.602111831117;4978.427480839678;4978.6763860348965;4990.750462476862;5227.843164705065;5238.659487133325;5291.708956007456;5306.097963346163;5314.256004159343;4941.65408421407;5165.199394093921;5169.172932330809;5190.197293461489;5204.687718736888;4968.826091086795;4981.427135879276;4983.72589507566;4990.276409920469;4992.400911890596;3742.101895545104;3771.245750849786;3788.7646288689807;3790;3792.9431058534697;5034.647574669738;5242.135047717084;5267.394249661338;5271.894562108813;5282.286891269783;5104;5117.74411279442;5120.155174396183;5122.1804511278015;5127.2052831811125;5055.977608956447;5074.340335756328;5084.618653600921;5091.414487334004;5112.769925353442;4870.756462176948;4921.63087768426;4997.525235102659;5007.424146223231;5029.84910452687;4880.219164933736;4925.310456536016;5078.593712502917;5103.77033033507;5110.79556817738;5007.447691215735;5015.523525265094;5022.4977502249485;5036.388355726132;5038.722870242172 13:36:42 INFO - PROCESS | 6196 | |5;yui.html;568.9601727879045;575.4964406144624;638.0970926139513;663.7942237906248;674.9595024298543;11106.111511079114;11301.26541774785;11402.7149321267;12190;12197.57308494204;12757.170783899062;13250;13332.266725330102;13368.465261389558;13377;638.1225814505055;658.6969993802857;660.7224965514472;757.2427572427587;781.7693780334815;647.8283254937422;765.873630850909;786.9881951770728;789.8301865099003;795.4511387142882;832.2135581875131;833.6707000734706;835.7952301686065;836.5817091454273;836.9288610468087;828.0477450931417;828.188375392119;828.3538839704979;828.3952714518405;828.4076885027234;608.0635820835907;608.2791891608458;608.4341562347015;608.6926102318345;608.8538750699845;11542.884571154265;11551.711207219803;11573.36346500942;11574.53701851925;11600.883991160064;11882.702932426671;12515.588367336777;12717;12765.553205637758;12973.870261297361;9404.15362617361;9449.811003779954;9613.423194608346;9655.903440965641;9668.178204852597;2911.461379644751;2920.2261400728826;2952.2619345163707;2990.641123065246;3039.4225097231456;57453.71273143649;57483.71258143724;58211.41788582102;59711;60380.39619603835;9708.320417570701;9735.090435674349;9930.05664461875;9986.750331241778;10238.027387398186;18102.637947240983;18609.7208541872;18617.162227699788;18628.16173272206;18662.253509859453;6238.1890354254565;6587.6047437152965;6664.700088496029;6950.131233595801;6956.095707558086;3729.8321575529167;3787.147891724395;3819.980900095482;3837.0791010157363;3837.3092843288478;2794.986025069902;2912.257374369522;2917.5186094294204;2917.7811664125275;2919.927001824929;481.67005601163316;482.9855104346875;484.8109237397418;496.2407516499761;496.9304297398367;461.39096392761235;477.07447551750187;512.4107276631903;521.919102539107;565.3074983145614;7160.140783106061;7267.345938865527;7279.89080163798;7451.254874512505;7662.61686915652;446.36838872994997;458.79124998125775;463.7704336353527;481.63877092180866;531.1262972410441;3538.7699799512948;3730.7948062856262;3778.7732736035928;3811.6950643948417;3929.724919255682;92929.31312898968;94570;96831;100040.49979750055;100051;43487.34768978468;63817.68091159607;63861;67738.32261677418;70844;43775.202492211836;69501.65249173722;71414.64292678607;72262.63868680623;72875.27124728684;8116.675332986614;8188.631511581874;8423;8451.197136272045;8494.575271236537;35007.299854003286;37902.62097378991;38266;38479;41599.7920010398;38321.80839095786;39083;39295.80352098221;49531;62978;10628.468576571295;10728.678139655824;10748.140148787921;10830.512626931964;11021.779564408507;12038.578649747216;12105.69735756613;12158.635240942785;12391.814122788346;12938.288394138413;11194.048505877092;11228.943855280671;11598.826017609912;12220;12372.443240054039;11327.32036077838;12167.634970950532;12169.878301217228;12610.36948152607;12673.556425525063;11197.272177308449;11209.71975700614;11393.373364465035;12006.399680016139;12013.699657508632;9298.95350523243;9756.41461512283;10051.145652619609;10184.898151018395;10374.118199953089;9199.724008279762;9419.434833909987;10189.36112280001;10306.690799276033;10335 13:36:42 INFO - PROCESS | 6196 | __end_tp_report 13:36:42 INFO - PROCESS | 6196 | __start_cc_report 13:36:42 INFO - PROCESS | 6196 | _x_x_mozilla_cycle_collect,1050 13:36:42 INFO - PROCESS | 6196 | __end_cc_report 13:36:42 INFO - PROCESS | 6196 | __startTimestamp1467232602679__endTimestamp 13:36:42 INFO - PROCESS | 6196 | 13:36:42 INFO - PROCESS | 6196 | ------- Summary: start ------- 13:36:42 INFO - PROCESS | 6196 | Number of tests: 6 13:36:42 INFO - PROCESS | 6196 | 13:36:42 INFO - PROCESS | 6196 | [#0] dojo.html Cycles:165 Average:4746.29 Median:4871.39 stddev:502.45 (10.3%) stddev-sans-first:476.35 13:36:42 INFO - PROCESS | 6196 | Values: 2651.2 2669.3 2691.7 2710.3 2710.6 4722.6 4795.2 4824.8 4826.3 4860.3 4804.8 4805.1 4834.9 4855.5 4873.9 4299.4 4307.9 4364.5 4480.3 4503.5 4354.7 4422.0 4447.4 4485.9 4520.4 4452.9 4485.1 4506.4 4510.6 4525.9 4278.9 4297.2 4303.3 4318.4 4322.8 4278.2 4301.1 4331.7 4331.8 4347.5 4760.8 4767.6 4787.0 4793.5 4799.4 4881.4 4962.9 5045.3 5061.5 5074.8 5085.9 5142.7 5154.9 5158.5 5168.7 4675.3 4795.3 4798.0 4798.3 4800.0 5312.0 5362.3 5363.6 5363.9 5427.6 5162.6 5204.7 5207.2 5209.3 5211.1 5002.3 5075.3 5280.5 5289.9 5291.3 5056.4 5073.8 5097.8 5102.5 5141.1 5060.3 5068.2 5075.1 5088.3 5124.4 4255.3 4280.1 4313.0 4387.1 4429.8 3821.9 3831.8 3841.5 3889.5 3905.6 4445.0 4452.4 4459.0 4499.3 4500.1 5038.1 5057.4 5076.9 5223.5 5291.7 4375.3 4386.1 4393.8 4438.9 4446.0 4586.0 4595.4 4597.5 4605.9 4645.9 4732.9 4840.0 4846.7 4854.6 4896.1 5192.4 5212.6 5226.5 5237.9 5267.8 4871.4 4894.8 4919.8 4920.1 4953.7 4945.8 4996.3 5042.8 5057.6 5112.8 5114.3 5125.5 5137.2 5138.8 5139.4 4964.8 4984.6 4988.2 5006.6 5034.0 4841.4 4955.3 4972.0 5003.0 5027.8 4877.5 4916.4 4919.9 4966.2 4974.9 4889.6 5034.3 5048.0 5050.9 5051.4 4815.7 4819.3 4863.2 4880.5 4927.7 13:36:42 INFO - PROCESS | 6196 | 13:36:42 INFO - PROCESS | 6196 | [#1] ext.html Cycles:180 Average:46525.05 Median:37620.53 stddev:85372.73 (226.9%) stddev-sans-first:85542.52 13:36:42 INFO - PROCESS | 6196 | Values: 578.8 587.9 595.6 597.7 603.4 27458.3 39304.2 40531.0 40573.6 43927.3 41016.4 41365.4 41461.4 41467.0 41468.8 7816.7 7956.0 7966.4 7966.9 7971.8 7840.1 7897.3 7932.6 7934.0 7936.3 7917.3 7960.9 7966.4 7971.9 7975.6 7894.3 7913.7 7935.0 7938.2 7944.2 7870.8 7946.0 7951.0 7956.0 7958.0 38921.8 39221.0 39224.8 39253.8 39291.8 2807.8 2812.5 2868.6 2875.1 2905.2 28326.7 29007.3 29124.4 29749.7 30237.7 3355.8 3362.2 3413.6 3421.3 3457.7 249495.0 249579.0 251004.0 251336.0 251444.0 32163.4 52268.2 52503.7 52542.0 52546.0 32096.8 34110.8 34299.8 34396.3 34431.5 13794.3 13997.3 14161.8 14167.7 14177.1 11332.3 11365.0 11485.8 11489.6 11507.2 7911.5 7918.3 7958.0 7981.1 8013.1 3114.7 3129.1 3156.7 3159.1 3191.8 794.9 833.4 895.7 901.4 927.9 28039.0 28178.9 28749.7 29256.3 29306.7 784.5 942.6 943.2 950.1 985.3 14357.6 14680.3 14713.3 14779.5 14816.2 380747.0 384375.0 384409.0 385056.0 387221.0 46860.5 48454.5 48487.8 48497.3 48603.3 1085.9 1164.9 1166.2 1182.7 1198.2 27883.4 28614.0 29352.6 29860.9 29887.9 41701.8 42128.0 42217.4 42229.6 42258.6 304424.0 307161.0 307874.0 308515.0 378231.0 25139.6 25526.7 25767.5 27124.2 27154.2 41819.0 42329.0 42654.4 43091.0 43165.0 36696.1 36781.8 37175.6 37186.0 37604.4 37367.0 37636.6 37774.6 37891.0 37982.6 36378.6 36800.6 36938.4 37541.8 37646.2 32064.8 33421.0 33474.3 33630.2 33877.7 24953.0 25371.1 25407.2 25637.7 26093.9 13:36:42 INFO - PROCESS | 6196 | 13:36:42 INFO - PROCESS | 6196 | [#2] jquery.html Cycles:180 Average:24718.17 Median:4921.25 stddev:67996.12 (1381.7%) stddev-sans-first:68162.28 13:36:42 INFO - PROCESS | 6196 | Values: 363.8 365.9 370.7 382.2 383.9 16486.9 17630.8 17952.3 18003.8 18027.1 16007.0 16593.8 18161.8 18170.5 18174.2 4699.1 4894.7 4916.7 4920.6 4921.9 3501.8 3661.6 4795.6 6025.7 6338.4 6321.8 6326.5 6367.2 6369.3 6375.4 5420.2 5563.7 5590.5 5599.5 5663.2 3386.5 5040.4 5258.0 5280.9 5286.7 12269.2 12269.6 12295.8 12380.7 12634.5 1771.3 1933.0 2081.8 2346.6 2373.1 9303.0 9499.7 11404.4 13015.7 13516.2 1782.9 1786.1 1788.5 1796.9 1850.1 65885.7 69159.7 69715.7 70100.3 72097.3 8456.9 8796.6 9125.1 9219.3 10143.3 11972.8 11997.2 12011.9 12080.7 12080.9 7210.6 7362.8 7378.6 7397.4 7399.4 7298.6 7339.7 7481.4 7500.6 7516.4 3653.1 3772.5 3773.4 3803.3 3897.3 1736.3 1771.4 1806.9 1829.3 1842.2 793.7 856.4 865.7 889.7 933.6 16644.5 17526.2 17585.2 17859.3 18280.5 867.9 870.6 890.6 904.1 916.7 10039.7 10139.2 10150.5 10210.1 10347.8 407515.0 411683.0 413196.0 413235.0 414947.0 75513.6 75834.0 77945.0 79133.0 80624.2 912.8 922.4 923.5 940.6 947.3 15450.4 15830.6 15879.8 16044.0 16387.2 37648.4 37681.4 37772.6 38906.6 39101.8 45861.8 51896.5 52803.7 53204.5 54097.5 7180.8 7210.9 7270.6 7325.6 7425.2 9040.5 11433.3 11493.7 11499.0 11567.5 9246.0 9304.1 9404.3 9569.1 9810.1 9742.2 10065.8 10111.9 10115.3 10140.3 9432.0 9508.7 9740.5 9793.0 9800.3 6314.6 6578.7 6657.6 7441.3 7565.9 8338.9 8604.9 8996.9 9393.5 9422.1 13:36:42 INFO - PROCESS | 6196 | 13:36:42 INFO - PROCESS | 6196 | [#3] mootools.html Cycles:180 Average:5049.13 Median:4974.53 stddev:2854.09 (57.4%) stddev-sans-first:2848.40 13:36:42 INFO - PROCESS | 6196 | Values: 1328.6 1380.2 1424.5 1633.0 1653.9 7368.8 7813.8 7881.5 7883.0 7893.7 6692.6 7401.3 7642.8 7664.4 7855.3 2146.3 2159.4 2160.5 2160.9 2171.8 1887.9 2107.5 2170.1 2177.3 2211.1 2150.7 2191.0 2202.2 2208.2 2210.0 2097.9 2106.1 2153.7 2154.0 2154.4 2113.8 2125.4 2132.4 2133.0 2135.5 7776.5 7899.2 7907.5 7909.9 7916.5 4417.2 4538.2 4539.2 4539.7 4540.1 2746.8 2787.6 2839.1 2851.9 2935.4 915.6 943.5 949.2 957.2 959.3 10429.3 10485.3 10490.7 10493.2 10498.7 3720.0 4029.7 4157.3 4166.0 4166.7 9042.3 9111.1 9123.5 9135.3 9135.5 4595.0 4626.5 4629.3 4631.5 4635.2 4094.3 4177.1 4210.3 4213.6 4214.9 3522.1 3552.0 3557.2 3568.5 3604.7 1070.2 1136.1 1181.7 1182.6 1197.0 705.4 708.4 719.3 728.8 729.2 4863.6 4905.1 4936.0 4960.7 4967.6 813.3 819.7 831.8 847.2 873.0 3206.3 3282.8 3301.5 3312.7 3360.1 9123.7 9508.2 9510.4 9630.1 9636.0 8352.3 9413.5 9508.6 9522.2 9524.0 6797.7 7103.9 7107.9 7208.1 7242.7 4936.0 4981.5 5051.4 5100.3 5147.1 8850.9 8902.8 8916.3 8926.8 8931.4 8782.0 8920.0 8960.9 9076.9 9104.5 6698.0 6721.1 6731.2 6750.9 6823.6 7421.0 7427.6 7479.4 7491.9 7493.4 6594.3 6682.5 6719.4 6887.0 7042.9 6600.6 6631.9 6651.6 6694.3 6706.3 6018.4 6036.9 6054.9 6058.7 6070.9 4357.9 4362.6 4368.9 4422.4 4468.6 4337.1 4369.6 4395.6 4404.4 4424.2 13:36:42 INFO - PROCESS | 6196 | 13:36:42 INFO - PROCESS | 6196 | [#4] prototype.html Cycles:180 Average:4214.06 Median:4848.59 stddev:1223.19 (25.2%) stddev-sans-first:1190.58 13:36:42 INFO - PROCESS | 6196 | Values: 287.2 291.5 295.2 295.5 302.4 4846.6 4897.0 4897.7 4906.6 4909.6 4827.5 4827.9 4833.6 4837.9 4839.2 3582.8 3713.5 3714.4 3797.0 3863.3 3763.4 3808.6 3826.4 3829.8 3843.9 3771.0 3776.6 3776.7 3777.3 3779.8 3562.5 3599.7 3750.4 3761.6 3762.8 3315.1 3318.5 3319.9 3320.8 3330.0 4699.8 4702.2 4711.6 4724.7 4746.6 4200.0 4279.3 4309.3 4314.4 4332.5 5011.3 5034.7 5038.6 5040.2 5048.5 3634.4 3639.0 3640.5 3643.9 3644.5 5071.7 5243.7 5273.8 5274.8 5286.6 3699.5 3713.2 3721.5 3726.4 3729.5 3737.2 3749.7 3751.5 3765.9 3768.6 4248.8 4251.7 4252.7 4260.2 4272.3 4850.5 4991.7 5023.5 5033.8 5043.6 1287.8 1302.9 1302.9 1309.3 1309.8 837.1 844.8 847.6 878.6 919.7 4408.3 4415.1 4416.4 4454.7 4466.0 5137.3 5143.5 5144.2 5163.9 5166.3 4242.9 4426.0 4430.4 4431.1 4431.2 2722.9 2747.2 2751.5 2788.2 2790.8 4930.6 4944.2 4946.0 4963.5 4963.8 5113.6 5283.1 5345.4 5352.5 5388.2 4954.3 4973.6 4978.4 4978.7 4990.8 5227.8 5238.7 5291.7 5306.1 5314.3 4941.7 5165.2 5169.2 5190.2 5204.7 4968.8 4981.4 4983.7 4990.3 4992.4 3742.1 3771.2 3788.8 3790.0 3792.9 5034.6 5242.1 5267.4 5271.9 5282.3 5104.0 5117.7 5120.2 5122.2 5127.2 5056.0 5074.3 5084.6 5091.4 5112.8 4870.8 4921.6 4997.5 5007.4 5029.8 4880.2 4925.3 5078.6 5103.8 5110.8 5007.4 5015.5 5022.5 5036.4 5038.7 13:36:42 INFO - PROCESS | 6196 | 13:36:42 INFO - PROCESS | 6196 | [#5] yui.html Cycles:180 Average:15960.44 Median:460.09 stddev:22404.27 (4869.5%) stddev-sans-first:22437.31 13:36:42 INFO - PROCESS | 6196 | Values: 569.0 575.5 638.1 663.8 675.0 11106.1 11301.3 11402.7 12190.0 12197.6 12757.2 13250.0 13332.3 13368.5 13377.0 638.1 658.7 660.7 757.2 781.8 647.8 765.9 787.0 789.8 795.5 832.2 833.7 835.8 836.6 836.9 828.0 828.2 828.4 828.4 828.4 608.1 608.3 608.4 608.7 608.9 11542.9 11551.7 11573.4 11574.5 11600.9 11882.7 12515.6 12717.0 12765.6 12973.9 9404.2 9449.8 9613.4 9655.9 9668.2 2911.5 2920.2 2952.3 2990.6 3039.4 57453.7 57483.7 58211.4 59711.0 60380.4 9708.3 9735.1 9930.1 9986.8 10238.0 18102.6 18609.7 18617.2 18628.2 18662.3 6238.2 6587.6 6664.7 6950.1 6956.1 3729.8 3787.1 3820.0 3837.1 3837.3 2795.0 2912.3 2917.5 2917.8 2919.9 481.7 483.0 484.8 496.2 496.9 461.4 477.1 512.4 521.9 565.3 7160.1 7267.3 7279.9 7451.3 7662.6 446.4 458.8 463.8 481.6 531.1 3538.8 3730.8 3778.8 3811.7 3929.7 92929.3 94570.0 96831.0 100040.5 100051.0 43487.3 63817.7 63861.0 67738.3 70844.0 43775.2 69501.7 71414.6 72262.6 72875.3 8116.7 8188.6 8423.0 8451.2 8494.6 35007.3 37902.6 38266.0 38479.0 41599.8 38321.8 39083.0 39295.8 49531.0 62978.0 10628.5 10728.7 10748.1 10830.5 11021.8 12038.6 12105.7 12158.6 12391.8 12938.3 11194.0 11228.9 11598.8 12220.0 12372.4 11327.3 12167.6 12169.9 12610.4 12673.6 11197.3 11209.7 11393.4 12006.4 12013.7 9299.0 9756.4 10051.1 10184.9 10374.1 9199.7 9419.4 10189.4 10306.7 10335.0 13:36:42 INFO - PROCESS | 6196 | -------- Summary: end -------- 13:36:42 INFO - PROCESS | 6196 | 13:36:43 INFO - TEST-INFO | 6196: exit 0 13:36:43 INFO - TEST-OK | dromaeo_css | took 1119993ms 13:36:43 INFO - TEST-START | kraken 13:36:43 INFO - operating with platform_type : linux_ 13:36:43 INFO - Initialising browser for kraken test... 13:36:43 INFO - TEST-INFO | started process 6385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU6ffw_/profile http://localhost:32950/getInfo.html) 13:36:47 INFO - PROCESS | 6385 | __metrics Screen width/height:1600/1200 13:36:47 INFO - PROCESS | 6385 | colorDepth:24 13:36:47 INFO - PROCESS | 6385 | Browser inner width/height: 1024/697 13:36:47 INFO - PROCESS | 6385 | __metrics 13:36:48 INFO - PROCESS | 6385 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:36:49 INFO - TEST-INFO | 6385: exit 0 13:36:49 INFO - Browser initialized. 13:36:49 INFO - Running cycle 1/1 for kraken test... 13:36:49 INFO - TEST-INFO | started process 6467 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU6ffw_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:37:01 INFO - PROCESS | 6467 | RSS: Main: 158937088 13:37:01 INFO - PROCESS | 6467 | 13:37:04 INFO - PROCESS | 6467 | Cycle 1(1): loaded http://localhost:32950/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32950/tests/kraken/driver.html?testName=audio-beat-detection) 13:37:05 INFO - PROCESS | 6467 | RSS: Main: 217194496 13:37:05 INFO - PROCESS | 6467 | 13:37:08 INFO - PROCESS | 6467 | Cycle 1(1): loaded http://localhost:32950/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32950/tests/kraken/driver.html?testName=audio-dft) 13:37:08 INFO - PROCESS | 6467 | RSS: Main: 205213696 13:37:08 INFO - PROCESS | 6467 | 13:37:11 INFO - PROCESS | 6467 | Cycle 1(1): loaded http://localhost:32950/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32950/tests/kraken/driver.html?testName=audio-fft) 13:37:12 INFO - PROCESS | 6467 | RSS: Main: 270721024 13:37:12 INFO - PROCESS | 6467 | 13:37:14 INFO - PROCESS | 6467 | Cycle 1(1): loaded http://localhost:32950/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32950/tests/kraken/driver.html?testName=audio-oscillator) 13:37:15 INFO - PROCESS | 6467 | RSS: Main: 181329920 13:37:15 INFO - PROCESS | 6467 | 13:37:17 INFO - PROCESS | 6467 | Cycle 1(1): loaded http://localhost:32950/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32950/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:37:18 INFO - PROCESS | 6467 | RSS: Main: 185298944 13:37:18 INFO - PROCESS | 6467 | 13:37:21 INFO - PROCESS | 6467 | Cycle 1(1): loaded http://localhost:32950/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32950/tests/kraken/driver.html?testName=imaging-darkroom) 13:37:21 INFO - PROCESS | 6467 | RSS: Main: 222425088 13:37:21 INFO - PROCESS | 6467 | 13:37:25 INFO - PROCESS | 6467 | Cycle 1(1): loaded http://localhost:32950/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32950/tests/kraken/driver.html?testName=imaging-desaturate) 13:37:26 INFO - PROCESS | 6467 | RSS: Main: 217997312 13:37:26 INFO - PROCESS | 6467 | 13:37:28 INFO - PROCESS | 6467 | Cycle 1(1): loaded http://localhost:32950/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32950/tests/kraken/driver.html?testName=json-parse-financial) 13:37:29 INFO - PROCESS | 6467 | RSS: Main: 220803072 13:37:29 INFO - PROCESS | 6467 | 13:37:31 INFO - PROCESS | 6467 | Cycle 1(1): loaded http://localhost:32950/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32950/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:37:31 INFO - PROCESS | 6467 | RSS: Main: 205737984 13:37:31 INFO - PROCESS | 6467 | 13:37:33 INFO - PROCESS | 6467 | Cycle 1(1): loaded http://localhost:32950/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32950/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:37:34 INFO - PROCESS | 6467 | RSS: Main: 210620416 13:37:34 INFO - PROCESS | 6467 | 13:37:36 INFO - PROCESS | 6467 | Cycle 1(1): loaded http://localhost:32950/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32950/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:37:37 INFO - PROCESS | 6467 | RSS: Main: 213622784 13:37:37 INFO - PROCESS | 6467 | 13:37:39 INFO - PROCESS | 6467 | Cycle 1(1): loaded http://localhost:32950/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32950/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:37:40 INFO - PROCESS | 6467 | RSS: Main: 231620608 13:37:40 INFO - PROCESS | 6467 | 13:37:43 INFO - PROCESS | 6467 | Cycle 1(1): loaded http://localhost:32950/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32950/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:37:44 INFO - PROCESS | 6467 | RSS: Main: 226136064 13:37:44 INFO - PROCESS | 6467 | 13:37:45 INFO - PROCESS | 6467 | Cycle 1(1): loaded http://localhost:32950/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32950/tests/kraken/driver.html?testName=ai-astar) 13:37:46 INFO - PROCESS | 6467 | RSS: Main: 268148736 13:37:46 INFO - PROCESS | 6467 | 13:37:46 INFO - PROCESS | 6467 | __start_tp_report 13:37:46 INFO - PROCESS | 6467 | _x_x_mozilla_page_load 13:37:46 INFO - PROCESS | 6467 | _x_x_mozilla_page_load_details 13:37:46 INFO - PROCESS | 6467 | |i|pagename|runs| 13:37:46 INFO - PROCESS | 6467 | |0;ai-astar;107;117;117;114;114;116;116;119;115;118 13:37:46 INFO - PROCESS | 6467 | |1;audio-beat-detection;165;122;125;178;125;126;150;123;161;128 13:37:46 INFO - PROCESS | 6467 | |2;audio-dft;162;162;162;160;163;162;162;162;162;163 13:37:46 INFO - PROCESS | 6467 | |3;audio-fft;76;77;76;117;76;78;76;75;107;76 13:37:46 INFO - PROCESS | 6467 | |4;audio-oscillator;85;88;118;85;85;85;120;85;86;133 13:37:46 INFO - PROCESS | 6467 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 13:37:46 INFO - PROCESS | 6467 | |6;imaging-darkroom;147;146;146;146;146;145;146;146;146;145 13:37:46 INFO - PROCESS | 6467 | |7;imaging-desaturate;95;95;95;95;94;94;95;95;95;94 13:37:46 INFO - PROCESS | 6467 | |8;json-parse-financial;63;64;64;63;63;64;64;64;64;64 13:37:46 INFO - PROCESS | 6467 | |9;json-stringify-tinderbox;65;64;65;65;64;63;64;65;66;64 13:37:46 INFO - PROCESS | 6467 | |10;stanford-crypto-aes;79;78;79;79;79;88;81;79;78;87 13:37:46 INFO - PROCESS | 6467 | |11;stanford-crypto-ccm;128;137;138;129;128;131;130;133;173;132 13:37:46 INFO - PROCESS | 6467 | |12;stanford-crypto-pbkdf2;176;173;175;174;174;173;171;174;172;171 13:37:46 INFO - PROCESS | 6467 | |13;stanford-crypto-sha256-iterative;69;69;69;69;69;70;70;67;68;71 13:37:46 INFO - PROCESS | 6467 | __end_tp_report 13:37:46 INFO - PROCESS | 6467 | __start_cc_report 13:37:46 INFO - PROCESS | 6467 | _x_x_mozilla_cycle_collect,1951 13:37:46 INFO - PROCESS | 6467 | __end_cc_report 13:37:46 INFO - PROCESS | 6467 | __startTimestamp1467232666188__endTimestamp 13:37:46 INFO - PROCESS | 6467 | 13:37:46 INFO - PROCESS | 6467 | ------- Summary: start ------- 13:37:46 INFO - PROCESS | 6467 | Number of tests: 14 13:37:46 INFO - PROCESS | 6467 | 13:37:46 INFO - PROCESS | 6467 | [#0] ai-astar Cycles:10 Average:115.30 Median:116.50 stddev:3.33 (2.9%) stddev-sans-first:1.72 13:37:46 INFO - PROCESS | 6467 | Values: 107.0 117.0 117.0 114.0 114.0 116.0 116.0 119.0 115.0 118.0 13:37:46 INFO - PROCESS | 6467 | 13:37:46 INFO - PROCESS | 6467 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:139.00 stddev:21.11 (15.2%) stddev-sans-first:20.42 13:37:46 INFO - PROCESS | 6467 | Values: 165.0 122.0 125.0 178.0 125.0 126.0 150.0 123.0 161.0 128.0 13:37:46 INFO - PROCESS | 6467 | 13:37:46 INFO - PROCESS | 6467 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 13:37:46 INFO - PROCESS | 6467 | Values: 162.0 162.0 162.0 160.0 163.0 162.0 162.0 162.0 162.0 163.0 13:37:46 INFO - PROCESS | 6467 | 13:37:46 INFO - PROCESS | 6467 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.00 stddev:15.28 (20.1%) stddev-sans-first:15.97 13:37:46 INFO - PROCESS | 6467 | Values: 76.0 77.0 76.0 117.0 76.0 78.0 76.0 75.0 107.0 76.0 13:37:46 INFO - PROCESS | 6467 | 13:37:46 INFO - PROCESS | 6467 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:85.00 stddev:18.82 (22.1%) stddev-sans-first:19.46 13:37:46 INFO - PROCESS | 6467 | Values: 85.0 88.0 118.0 85.0 85.0 85.0 120.0 85.0 86.0 133.0 13:37:46 INFO - PROCESS | 6467 | 13:37:46 INFO - PROCESS | 6467 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 13:37:46 INFO - PROCESS | 6467 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 13:37:46 INFO - PROCESS | 6467 | 13:37:46 INFO - PROCESS | 6467 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 13:37:46 INFO - PROCESS | 6467 | Values: 147.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 13:37:46 INFO - PROCESS | 6467 | 13:37:46 INFO - PROCESS | 6467 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:37:46 INFO - PROCESS | 6467 | Values: 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 13:37:46 INFO - PROCESS | 6467 | 13:37:46 INFO - PROCESS | 6467 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 13:37:46 INFO - PROCESS | 6467 | Values: 63.0 64.0 64.0 63.0 63.0 64.0 64.0 64.0 64.0 64.0 13:37:46 INFO - PROCESS | 6467 | 13:37:46 INFO - PROCESS | 6467 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 13:37:46 INFO - PROCESS | 6467 | Values: 65.0 64.0 65.0 65.0 64.0 63.0 64.0 65.0 66.0 64.0 13:37:46 INFO - PROCESS | 6467 | 13:37:46 INFO - PROCESS | 6467 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:79.00 stddev:3.68 (4.7%) stddev-sans-first:3.86 13:37:46 INFO - PROCESS | 6467 | Values: 79.0 78.0 79.0 79.0 79.0 88.0 81.0 79.0 78.0 87.0 13:37:46 INFO - PROCESS | 6467 | 13:37:46 INFO - PROCESS | 6467 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:132.50 stddev:13.49 (10.2%) stddev-sans-first:14.00 13:37:46 INFO - PROCESS | 6467 | Values: 128.0 137.0 138.0 129.0 128.0 131.0 130.0 133.0 173.0 132.0 13:37:46 INFO - PROCESS | 6467 | 13:37:46 INFO - PROCESS | 6467 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:174.00 stddev:1.64 (0.9%) stddev-sans-first:1.41 13:37:46 INFO - PROCESS | 6467 | Values: 176.0 173.0 175.0 174.0 174.0 173.0 171.0 174.0 172.0 171.0 13:37:46 INFO - PROCESS | 6467 | 13:37:46 INFO - PROCESS | 6467 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 13:37:46 INFO - PROCESS | 6467 | Values: 69.0 69.0 69.0 69.0 69.0 70.0 70.0 67.0 68.0 71.0 13:37:46 INFO - PROCESS | 6467 | -------- Summary: end -------- 13:37:46 INFO - PROCESS | 6467 | 13:37:47 INFO - TEST-INFO | 6467: exit 0 13:37:47 INFO - TEST-OK | kraken | took 63812ms 13:37:47 INFO - SUITE-END | took 1183s 13:37:47 INFO - Completed test suite (00:19:43) 13:37:47 INFO - javascript benchmark 13:37:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2651.1516314779274, 2669.3059804450836, 2691.703912569617, 2710.3359676879154, 2710.5934109883515, 4722.551357621029, 4795.184818580841, 4824.831130910419, 4826.324314595955, 4860.319555262262, 4804.807807687688, 4805.087033463639, 4834.854954351375, 4855.465898751135, 4873.926891096637, 4299.44107266055, 4307.870763877073, 4364.49808272048, 4480.2607569751035, 4503.504614492404, 4354.716943398669, 4422.0, 4447.421835161441, 4485.932711009337, 4520.434945631796, 4452.888677783049, 4485.058137791068, 4506.436695413074, 4510.639148868099, 4525.909481810362, 4278.871633850989, 4297.226499230137, 4303.289957157065, 4318.4170137031415, 4322.805473753689, 4278.2085314216965, 4301.096769678371, 4331.675124365654, 4331.805068771912, 4347.456567929009, 4760.7619619018915, 4767.642426818003, 4786.952130478686, 4793.544613261734, 4799.352087468217, 4881.365422495089, 4962.900741985176, 5045.318881950926, 5061.519155680205, 5074.771635276385, 5085.923711144335, 5142.74286285688, 5154.9484505155215, 5158.535731784157, 5168.715720635363, 4675.29870519418, 4795.304680821261, 4797.95202047982, 4798.256270278147, 4799.976000120047, 5312.0, 5362.27609272751, 5363.624546281723, 5363.892722145613, 5427.647202931876, 5162.586993040548, 5204.713740744295, 5207.1668533034535, 5209.29674493946, 5211.114110601206, 5002.274670172805, 5075.3148324975655, 5280.471952804765, 5289.894202115936, 5291.285676433632, 5056.443791182967, 5073.797048118107, 5097.770600322994, 5102.464241254689, 5141.126008578551, 5060.291559181717, 5068.189089745623, 5075.137226671474, 5088.313077734459, 5124.359455068116, 4255.276602977501, 4280.101178752435, 4312.956870431255, 4387.078713470143, 4429.80065897029, 3821.9426708599394, 3831.7509361891944, 3841.5006049213425, 3889.5138107736534, 3905.5703872573995, 4445.0, 4452.443444569429, 4458.9554104459185, 4499.347594598765, 4500.099980004013, 5038.118329292359, 5057.393112826484, 5076.923846142311, 5223.451537588575, 5291.682499050069, 4375.290246228638, 4386.144701783185, 4393.802278897458, 4438.889027774267, 4445.977425192224, 4586.0, 4595.356650068993, 4597.494275629678, 4605.884852878705, 4645.860624181212, 4732.929006064843, 4839.975800120977, 4846.684965477232, 4854.635902307412, 4896.094222568836, 5192.42883282831, 5212.582993360598, 5226.503482169188, 5237.895242095213, 5267.815626453055, 4871.391076115486, 4894.804207831647, 4919.778609962632, 4920.065187614342, 4953.72754498506, 4945.826896058621, 4996.2505624156665, 5042.84871453857, 5057.620678449204, 5112.846614601568, 5114.284000239895, 5125.469294549993, 5137.17805151174, 5138.768755405941, 5139.357580302462, 4964.751762411793, 4984.601231901512, 4988.226824842155, 5006.624503162205, 5034.018366418513, 4841.370621819282, 4955.331030311006, 4971.950280497149, 5003.049420610072, 5027.84916452507, 4877.512248775094, 4916.360873086619, 4919.901601968012, 4966.205407134841, 4974.875628109182, 4889.584385327287, 5034.2951986721155, 5048.0, 5050.898982020412, 5051.393832740095, 4815.7351345676325, 4819.2530157825595, 4863.173260545786, 4880.536349046835, 4927.655064145475], "value": 4714.157568486278, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.8321386797829, 587.9353271140174, 595.5890435599439, 597.742970522675, 603.381533927724, 27458.31354216143, 39304.2139157217, 40531.0, 40573.59426405735, 43927.3410898836, 41016.38475422864, 41365.37951930716, 41461.37807932876, 41467.0, 41468.792656036756, 7816.726414575491, 7955.96022019892, 7966.4025198110085, 7966.880496792553, 7971.760847174565, 7840.098388685288, 7897.328727058207, 7932.643031063587, 7934.0, 7936.285734283913, 7917.327027202695, 7960.880586791202, 7966.4025198110085, 7971.920280797205, 7975.60121993898, 7894.3289820365335, 7913.723019694283, 7935.047794264668, 7938.24586664266, 7944.2055794420385, 7870.763877083639, 7946.0, 7951.04587449504, 7956.0, 7958.045034595828, 38921.805390973146, 39221.0, 39224.803875980724, 39253.80373098116, 39291.8035409824, 2807.83153010818, 2812.493751124817, 2868.6127372804613, 2875.1087162979543, 2905.186547766629, 28326.716732832614, 29007.274818129503, 29124.41751164986, 29749.70250297491, 30237.69762302371, 3355.832208389595, 3362.231661346781, 3413.5562376890844, 3421.275499843984, 3457.6888080072913, 249495.0, 249579.0, 251004.0, 251336.0, 251444.0, 32163.356732865213, 52268.21597676038, 52503.737481312346, 52542.0, 52546.0, 32096.839515802272, 34110.829445852614, 34299.82850085734, 34396.31207375838, 34431.48352774711, 13794.310284485735, 13997.34050530396, 14161.78757318641, 14167.716645667235, 14177.14937103777, 11332.263402878787, 11365.0, 11485.770284594428, 11489.597864074718, 11507.19449638534, 7911.496815605016, 7918.28735413804, 7958.0, 7981.082175549886, 8013.11855695873, 3114.6885311468673, 3129.0925631567047, 3156.6899736609507, 3159.0996565978585, 3191.760617953663, 794.8767940969159, 833.3541505333294, 895.713371721043, 901.4320977784085, 927.8515437529962, 28039.0, 28178.85910570475, 28749.712502874703, 29256.26859328534, 29306.706932930825, 784.4587234807964, 942.6323733743845, 943.165298710646, 950.092661508258, 985.2856678907734, 14357.56927292183, 14680.265986700835, 14713.264336783119, 14779.482718104815, 14816.185109818847, 380747.0, 384375.0, 384409.0, 385056.0, 387221.0, 46860.531394686295, 48454.51545484571, 48487.75756121197, 48497.272540911916, 48603.27095093577, 1085.907697845692, 1164.9301041937342, 1166.2361153444508, 1182.692499950002, 1198.2151690642643, 27883.44233115367, 28614.0, 29352.55971160477, 29860.850695746383, 29887.850560747058, 41701.79149104235, 42128.0, 42217.36673949832, 42229.57770422257, 42258.57741422547, 304424.0, 307161.0, 307874.0, 308515.0, 378231.0, 25139.622905656062, 25526.744732552437, 25767.484650307262, 27124.1862744118, 27154.1853744388, 41818.96804528962, 42329.0, 42654.36018459663, 43091.0, 43165.0, 36696.0825979342, 36781.816090919376, 37175.628243718296, 37186.0, 37604.435933461566, 37367.0, 37636.62363376331, 37774.62225377711, 37891.0, 37982.620173797906, 36378.636213637525, 36800.63199368079, 36938.44592331063, 37541.81229093837, 37646.2470750578, 32064.83967580147, 33421.0, 33474.33051338911, 33630.159246019044, 33877.66122338745, 24953.0, 25371.112011079524, 25407.237782866545, 25637.74362256428, 26093.869530652224], "value": 16558.502041126238, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.82354558039344, 365.88840403676875, 370.6978812268001, 382.23552894211576, 383.8733218038044, 16486.917565412172, 17630.82369176308, 17952.281908723635, 18003.81996180038, 18027.098645067745, 16007.0, 16593.83406165938, 18161.818381816178, 18170.45488635343, 18174.182161802717, 4699.0836786826585, 4894.657373983822, 4916.729579873106, 4920.581750551208, 4921.926171107436, 3501.8424170912244, 3661.6338366163436, 4795.592374648159, 6025.698715064251, 6338.366163383671, 6321.841953951142, 6326.462250708695, 6367.172267605228, 6369.267534233553, 6375.394337537927, 5420.159875219328, 5563.721813909308, 5590.524805391527, 5599.468050535193, 5663.178839068312, 3386.542816719736, 5040.445550989388, 5258.027264955957, 5280.867978300574, 5286.682799032071, 12269.202501837352, 12269.57056503027, 12295.754084918251, 12380.690482737913, 12634.49462021518, 1771.2737777511288, 1932.951676208092, 2081.760597531288, 2346.5658853112227, 2373.062640257089, 9303.0, 9499.667511637059, 11404.429778511125, 13015.739685206243, 13516.189028658213, 1782.9019403932778, 1786.1337251433044, 1788.5439213000732, 1796.8652351073722, 1850.1211924335967, 65885.67057164731, 69159.65420172867, 69715.65142174307, 70100.29899700989, 72097.27902720959, 8456.8731469028, 8796.560171991376, 9125.133112354315, 9219.308551858638, 10143.289969702199, 11972.760544789055, 11997.220180688402, 12011.939940300243, 12080.697982550331, 12080.879191207976, 7210.603416812126, 7362.77911662651, 7378.5941773202985, 7397.408207343399, 7399.4450416219, 7298.598577078312, 7339.669714862844, 7481.438892083115, 7500.624968751541, 7516.361109305661, 3653.1415117447377, 3772.4529943158636, 3773.4339849022867, 3803.3344164771056, 3897.2595206911164, 1736.2881218700525, 1771.406578796092, 1806.9006204658608, 1829.2500074969464, 1842.2170577504507, 793.6507936507918, 856.4475913036057, 865.7013330401002, 889.7330800759876, 933.6312156698202, 16644.50066498007, 17526.21132049061, 17585.20866561008, 17859.28562857471, 18280.45158645243, 867.8958524976916, 870.6169285514353, 890.5814267294361, 904.0778406025817, 916.7433118726767, 10039.72983710764, 10139.188864890792, 10150.543225554868, 10210.081092701692, 10347.844782328271, 407515.0, 411683.0, 413196.0, 413235.0, 414947.0, 75513.62243188749, 75834.0, 77945.0, 79133.0, 80624.19375806166, 912.7763697894059, 922.3727865051695, 923.4736200365861, 940.6331530703031, 947.2847999760137, 15450.381984720934, 15830.604234893759, 15879.841201587837, 16044.0, 16387.180640967665, 37648.43527347147, 37681.43477847889, 37772.62227377691, 38906.61093389143, 39101.80449097736, 45861.82457050934, 51896.481035189165, 52803.73598131985, 53204.46795531995, 54097.45902540924, 7180.820479488055, 7210.9278907210255, 7270.636468176464, 7325.633718313957, 7425.183229844604, 9040.547972601475, 11433.256838305484, 11493.655190344303, 11499.0, 11567.479463423997, 9246.0, 9304.092661004343, 9404.341696081208, 9569.138777510057, 9810.068043535854, 9742.220622350336, 10065.798684026426, 10111.949440252753, 10115.342502737298, 10140.29017968735, 9431.952840235756, 9508.667196648084, 9740.464274464972, 9793.0, 9800.31397802147, 6314.589551679126, 6578.736850525926, 6657.600543967377, 7441.330280274801, 7565.924340756742, 8338.87491687613, 8604.870926936226, 8996.86504702443, 9393.530323483936, 9422.128118570787], "value": 8054.452690600198, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.6213429172685, 1380.2063813307348, 1424.501424501424, 1632.9673406531863, 1653.9421120260786, 7368.815779605513, 7813.765587032398, 7881.5271083735015, 7883.0, 7893.684252629895, 6692.63190524521, 7401.2598740126095, 7642.770716878488, 7664.386849052076, 7855.332296754783, 2146.259540458543, 2159.373781603341, 2160.481484443738, 2160.8595441296343, 2171.815395691368, 1887.9339223127192, 2107.5047363869553, 2170.1427935965285, 2177.3032629558547, 2211.137656314039, 2150.709654196687, 2191.0468946008536, 2202.2402271216483, 2208.249195273607, 2209.9668504972437, 2097.8531502794885, 2106.115431518766, 2153.686251386653, 2153.9876258158642, 2154.353693891826, 2113.7569179544244, 2125.3836387447623, 2132.41358626379, 2132.978670213309, 2135.519508110678, 7776.533407995538, 7899.210078992112, 7907.525548467052, 7909.881351779728, 7916.525008499509, 4417.249067658506, 4538.160440318518, 4539.205639013193, 4539.659525535565, 4540.137373898981, 2746.7665248453904, 2787.6097346371525, 2839.1198728394265, 2851.885924563015, 2935.412917416525, 915.5513798238882, 943.4999450291357, 949.2311227905419, 957.1672644798999, 959.3188835926501, 10429.322094063937, 10485.31845430037, 10490.685279441628, 10493.160547156209, 10498.685039448828, 3719.9814000930364, 4029.6776257899296, 4157.272477316457, 4165.97917010413, 4166.687498437629, 9042.276617870555, 9111.134442227978, 9123.543822808833, 9135.269178465707, 9135.54322283883, 4595.012072404449, 4626.4910859805395, 4629.259318509023, 4631.51369106239, 4635.165670179333, 4094.303968325392, 4177.081042170717, 4210.263203939298, 4213.6207741302815, 4214.894627634334, 3522.1370764162943, 3551.982240088783, 3557.217412169319, 3568.4825700273836, 3604.7296452766145, 1070.2347821307803, 1136.0797753819268, 1181.710480932177, 1182.6392950150287, 1196.9581064662696, 705.3827900586987, 708.4332533972802, 719.3346154806783, 728.8323685552247, 729.16510595368, 4863.610911127102, 4905.141600219948, 4936.0, 4960.677555958851, 4967.552920237196, 813.276184196066, 819.7376839411331, 831.7629475599425, 847.1824689174975, 872.9738107856774, 3206.3266713989856, 3282.7537934654997, 3301.5377847101427, 3312.734981201498, 3360.1263671445113, 9123.680671176477, 9508.191803696764, 9510.38182518148, 9630.133288003974, 9636.0, 8352.331813454908, 9413.529323533796, 9508.572114254875, 9522.190613797904, 9524.0, 6797.728090876409, 7103.893441598277, 7107.857842843217, 7208.062951816335, 7242.710291588278, 4935.975320123376, 4981.501849815135, 5051.419086805065, 5100.311457953278, 5147.073526765069, 8850.911490885266, 8902.777430564287, 8916.28669706409, 8926.776830579287, 8931.419457735226, 8782.0, 8919.955400222958, 8960.86558701607, 9076.909230907606, 9104.544772761468, 6698.028785826125, 6721.059051732664, 6731.1922569292, 6750.932490675031, 6823.55646882951, 7421.0, 7427.5914824683, 7479.364254038468, 7491.925080749123, 7493.4379921505015, 6594.307597702172, 6682.46540276767, 6719.395254427125, 6887.0, 7042.859142817218, 6600.570962887397, 6631.933680663132, 6651.600903945779, 6694.330566943267, 6706.295838936841, 6018.398160183947, 6036.88317661234, 6054.878902421839, 6058.666773327509, 6070.939290607037, 4357.869263922087, 4362.563743625739, 4368.890777730582, 4422.447194100738, 4468.597826195528, 4337.067530480836, 4369.60673539383, 4395.560443955579, 4404.4494438195225, 4424.225760491837], "value": 4050.457142698305, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.15862522808163, 291.5495559360787, 295.22945113254417, 295.5227307897746, 302.4329382407985, 4846.636502262331, 4896.9755151224235, 4897.706137631744, 4906.607471402288, 4909.631777616675, 4827.468978412372, 4827.855164345066, 4833.613310935126, 4837.879053023667, 4839.2499162629765, 3582.7850328980344, 3713.4801127842125, 3714.3685573452576, 3796.9810150949343, 3863.343231650612, 3763.435484677293, 3808.5620153682403, 3826.4069069294164, 3829.751066180703, 3843.8846834594865, 3770.9622903770887, 3776.622337766229, 3776.678982286509, 3777.3200823851835, 3779.81100944953, 3562.4656301554846, 3599.7120230381506, 3750.4186851038135, 3761.567419746737, 3762.7930463824478, 3315.055209265372, 3318.4856347266214, 3319.9004029879143, 3320.8173550454717, 3329.96670033299, 4699.788509517046, 4702.247640377557, 4711.575958163748, 4724.6928949618505, 4746.596539294164, 4199.9790001050105, 4279.272523670983, 4309.288967320388, 4314.439122914001, 4332.501762297313, 5011.273365362039, 5034.697918124888, 5038.622103342227, 5040.243963405482, 5048.5203905628905, 3634.436662317345, 3638.981805090984, 3640.4903313536124, 3643.890683279506, 3644.5262115925025, 5071.746412679388, 5243.737813109329, 5273.841784746425, 5274.762635681365, 5286.60350473716, 3699.483211883115, 3713.2387860488534, 3721.497597824259, 3726.403775395978, 3729.4965179700935, 3737.159139193714, 3749.6625303722794, 3751.531058617673, 3765.8681946131755, 3768.6042965488778, 4248.830046798155, 4251.6598672106775, 4252.659787217015, 4260.190563792869, 4272.273713468718, 4850.53919877611, 4991.725455099931, 5023.522765337287, 5033.803534755457, 5043.620774081374, 1287.8132670762875, 1302.8631993640531, 1302.9022823288292, 1309.3387839141174, 1309.7707901117267, 837.1126605797874, 844.8425656850154, 847.576211894053, 878.5519385113638, 919.7424721078108, 4408.25059739845, 4415.139047885631, 4416.381706561084, 4454.685867669045, 4466.0, 5137.306463627438, 5143.537081662668, 5144.2283657450935, 5163.948360516347, 5166.302549155891, 4242.8727138185905, 4426.0, 4430.357598148251, 4431.135928493977, 4431.246688063037, 2722.9319267018086, 2747.162115554735, 2751.5047291487726, 2788.1914244868763, 2790.804643674923, 4930.556249937523, 4944.233643785219, 4945.950540494549, 4963.503649635008, 4963.8262660806695, 5113.642045056885, 5283.0942981360095, 5345.38528069277, 5352.5450336721815, 5388.218708287276, 4954.281629163823, 4973.602111831117, 4978.427480839678, 4978.6763860348965, 4990.750462476862, 5227.843164705065, 5238.659487133325, 5291.708956007456, 5306.097963346163, 5314.256004159343, 4941.65408421407, 5165.199394093921, 5169.172932330809, 5190.197293461489, 5204.687718736888, 4968.826091086795, 4981.427135879276, 4983.72589507566, 4990.276409920469, 4992.400911890596, 3742.101895545104, 3771.245750849786, 3788.7646288689807, 3790.0, 3792.9431058534697, 5034.647574669738, 5242.135047717084, 5267.394249661338, 5271.894562108813, 5282.286891269783, 5104.0, 5117.74411279442, 5120.155174396183, 5122.1804511278015, 5127.2052831811125, 5055.977608956447, 5074.340335756328, 5084.618653600921, 5091.414487334004, 5112.769925353442, 4870.756462176948, 4921.63087768426, 4997.525235102659, 5007.424146223231, 5029.84910452687, 4880.219164933736, 4925.310456536016, 5078.593712502917, 5103.77033033507, 5110.79556817738, 5007.447691215735, 5015.523525265094, 5022.4977502249485, 5036.388355726132, 5038.722870242172], "value": 3823.7980409113784, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.9601727879045, 575.4964406144624, 638.0970926139513, 663.7942237906248, 674.9595024298543, 11106.111511079114, 11301.26541774785, 11402.7149321267, 12190.0, 12197.57308494204, 12757.170783899062, 13250.0, 13332.266725330102, 13368.465261389558, 13377.0, 638.1225814505055, 658.6969993802857, 660.7224965514472, 757.2427572427587, 781.7693780334815, 647.8283254937422, 765.873630850909, 786.9881951770728, 789.8301865099003, 795.4511387142882, 832.2135581875131, 833.6707000734706, 835.7952301686065, 836.5817091454273, 836.9288610468087, 828.0477450931417, 828.188375392119, 828.3538839704979, 828.3952714518405, 828.4076885027234, 608.0635820835907, 608.2791891608458, 608.4341562347015, 608.6926102318345, 608.8538750699845, 11542.884571154265, 11551.711207219803, 11573.36346500942, 11574.53701851925, 11600.883991160064, 11882.702932426671, 12515.588367336777, 12717.0, 12765.553205637758, 12973.870261297361, 9404.15362617361, 9449.811003779954, 9613.423194608346, 9655.903440965641, 9668.178204852597, 2911.461379644751, 2920.2261400728826, 2952.2619345163707, 2990.641123065246, 3039.4225097231456, 57453.71273143649, 57483.71258143724, 58211.41788582102, 59711.0, 60380.39619603835, 9708.320417570701, 9735.090435674349, 9930.05664461875, 9986.750331241778, 10238.027387398186, 18102.637947240983, 18609.7208541872, 18617.162227699788, 18628.16173272206, 18662.253509859453, 6238.1890354254565, 6587.6047437152965, 6664.700088496029, 6950.131233595801, 6956.095707558086, 3729.8321575529167, 3787.147891724395, 3819.980900095482, 3837.0791010157363, 3837.3092843288478, 2794.986025069902, 2912.257374369522, 2917.5186094294204, 2917.7811664125275, 2919.927001824929, 481.67005601163316, 482.9855104346875, 484.8109237397418, 496.2407516499761, 496.9304297398367, 461.39096392761235, 477.07447551750187, 512.4107276631903, 521.919102539107, 565.3074983145614, 7160.140783106061, 7267.345938865527, 7279.89080163798, 7451.254874512505, 7662.61686915652, 446.36838872994997, 458.79124998125775, 463.7704336353527, 481.63877092180866, 531.1262972410441, 3538.7699799512948, 3730.7948062856262, 3778.7732736035928, 3811.6950643948417, 3929.724919255682, 92929.31312898968, 94570.0, 96831.0, 100040.49979750055, 100051.0, 43487.34768978468, 63817.68091159607, 63861.0, 67738.32261677418, 70844.0, 43775.202492211836, 69501.65249173722, 71414.64292678607, 72262.63868680623, 72875.27124728684, 8116.675332986614, 8188.631511581874, 8423.0, 8451.197136272045, 8494.575271236537, 35007.299854003286, 37902.62097378991, 38266.0, 38479.0, 41599.7920010398, 38321.80839095786, 39083.0, 39295.80352098221, 49531.0, 62978.0, 10628.468576571295, 10728.678139655824, 10748.140148787921, 10830.512626931964, 11021.779564408507, 12038.578649747216, 12105.69735756613, 12158.635240942785, 12391.814122788346, 12938.288394138413, 11194.048505877092, 11228.943855280671, 11598.826017609912, 12220.0, 12372.443240054039, 11327.32036077838, 12167.634970950532, 12169.878301217228, 12610.36948152607, 12673.556425525063, 11197.272177308449, 11209.71975700614, 11393.373364465035, 12006.399680016139, 12013.699657508632, 9298.95350523243, 9756.41461512283, 10051.145652619609, 10184.898151018395, 10374.118199953089, 9199.724008279762, 9419.434833909987, 10189.36112280001, 10306.690799276033, 10335.0], "value": 6173.814372188957, "unit": "score"}], "name": "dromaeo_css", "value": 6259.074712154535, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 117.0, 114.0, 114.0, 116.0, 116.0, 119.0, 115.0, 118.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 122.0, 125.0, 178.0, 125.0, 126.0, 150.0, 123.0, 161.0, 128.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 160.0, 163.0, 162.0, 162.0, 162.0, 162.0, 163.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 117.0, 76.0, 78.0, 76.0, 75.0, 107.0, 76.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 118.0, 85.0, 85.0, 85.0, 120.0, 85.0, 86.0, 133.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 64.0, 63.0, 64.0, 65.0, 66.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 79.0, 79.0, 88.0, 81.0, 79.0, 78.0, 87.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 137.0, 138.0, 129.0, 128.0, 131.0, 130.0, 133.0, 173.0, 132.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 173.0, 175.0, 174.0, 174.0, 173.0, 171.0, 174.0, 172.0, 171.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 69.0, 69.0, 70.0, 70.0, 67.0, 68.0, 71.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1542.8000000000002, "alertThreshold": 2.0}]} 13:37:47 INFO - Return code: 0 13:37:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:37:47 INFO - # TBPL SUCCESS # 13:37:47 INFO - Running post-action listener: _resource_record_post_action 13:37:47 INFO - ##### 13:37:47 INFO - ##### Finished run-tests step (success) 13:37:47 INFO - ##### 13:37:47 INFO - Running post-run listener: _resource_record_post_run 13:37:47 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 538603520; Read time: 0; Write time: 505024 13:37:47 INFO - TinderboxPrint: CPU usage
13.0% 13:37:47 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:37:47 INFO - TinderboxPrint: I/O write bytes / time
538,603,520 / 505,024 13:37:47 INFO - TinderboxPrint: CPU idle
8,335.5 (87.0%) 13:37:47 INFO - TinderboxPrint: CPU user
1,199.7 (12.5%) 13:37:47 INFO - TinderboxPrint: Swap in / out
0 / 0 13:37:47 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 250183680; Read time: 0; Write time: 295544 13:37:47 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 288419840; Read time: 0; Write time: 209480 13:37:48 INFO - Running post-run listener: _upload_blobber_files 13:37:48 INFO - Blob upload gear active. 13:37:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:37:48 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 13:37:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:37:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:37:48 INFO - (blobuploader) - INFO - Open directory for files ... 13:37:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:37:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:37:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:49 INFO - (blobuploader) - INFO - Done attempting. 13:37:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:37:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:37:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:50 INFO - (blobuploader) - INFO - Done attempting. 13:37:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:37:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:37:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:54 INFO - (blobuploader) - INFO - Done attempting. 13:37:54 INFO - (blobuploader) - INFO - Iteration through files over. 13:37:54 INFO - Return code: 0 13:37:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:37:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:37:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8bc7bcc4221c322943e9e5d3576778a4046bc23ab31a181ff567db675ff4111a5c761384f5296ed41dcaae1aaead23c40d982d201ccf723ff4c823a234ea9bf7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d054d63406a24630bf4f0135a0fedd59bbecee898727995925cf384cb1009ddc274a066b88b5801a58f1a4ea9bc073d8b2b68738a510f5c13deb0bbd822ff67", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/86e1a85b58cf099cb6afd6a0e83d88f191a11607ce6a57bcf78bf166b50fbdfa12e3252d7e9ce9eda20f0069f839cf4bc207e15df7203e388eda95fde3f55d20"} 13:37:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:37:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:37:54 INFO - Contents: 13:37:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8bc7bcc4221c322943e9e5d3576778a4046bc23ab31a181ff567db675ff4111a5c761384f5296ed41dcaae1aaead23c40d982d201ccf723ff4c823a234ea9bf7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d054d63406a24630bf4f0135a0fedd59bbecee898727995925cf384cb1009ddc274a066b88b5801a58f1a4ea9bc073d8b2b68738a510f5c13deb0bbd822ff67", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/86e1a85b58cf099cb6afd6a0e83d88f191a11607ce6a57bcf78bf166b50fbdfa12e3252d7e9ce9eda20f0069f839cf4bc207e15df7203e388eda95fde3f55d20"} 13:37:54 INFO - Running post-run listener: copy_logs_to_upload_dir 13:37:54 INFO - Copying logs to upload dir... 13:37:54 INFO - mkdir: /builds/slave/test/build/upload/logs 13:37:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.413885 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-29 13:37:54.337407) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 13:37:54.340968) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8bc7bcc4221c322943e9e5d3576778a4046bc23ab31a181ff567db675ff4111a5c761384f5296ed41dcaae1aaead23c40d982d201ccf723ff4c823a234ea9bf7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d054d63406a24630bf4f0135a0fedd59bbecee898727995925cf384cb1009ddc274a066b88b5801a58f1a4ea9bc073d8b2b68738a510f5c13deb0bbd822ff67", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/86e1a85b58cf099cb6afd6a0e83d88f191a11607ce6a57bcf78bf166b50fbdfa12e3252d7e9ce9eda20f0069f839cf4bc207e15df7203e388eda95fde3f55d20"} build_url:https://queue.taskcluster.net/v1/task/co3RKOIIRum4aFGuj56pmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011418 build_url: 'https://queue.taskcluster.net/v1/task/co3RKOIIRum4aFGuj56pmQ/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/Fx-Team-Non-PGO/sha512/8bc7bcc4221c322943e9e5d3576778a4046bc23ab31a181ff567db675ff4111a5c761384f5296ed41dcaae1aaead23c40d982d201ccf723ff4c823a234ea9bf7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d054d63406a24630bf4f0135a0fedd59bbecee898727995925cf384cb1009ddc274a066b88b5801a58f1a4ea9bc073d8b2b68738a510f5c13deb0bbd822ff67", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/86e1a85b58cf099cb6afd6a0e83d88f191a11607ce6a57bcf78bf166b50fbdfa12e3252d7e9ce9eda20f0069f839cf4bc207e15df7203e388eda95fde3f55d20"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 13:37:54.366747) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:37:54.367097) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467231432.869580-1277152180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004684 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:37:54.450481) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 13:37:54.450807) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 13:37:54.451125) ========= ========= Total master_lag: 0.17 =========