builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-028 starttime: 1467197885.59 results: success (0) buildid: 20160629024426 builduid: c4b2b1ffda9647cf82fd357451c1dbc0 revision: 9811b75c23b96078bb698e6949ca91b1adc4c95e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 03:58:05.591343) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 03:58:05.591789) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 03:58:05.592135) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 03:58:05.613525) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 03:58:05.613852) ========= 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=836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 03:58:05-- 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% 45.9M=0s 2016-06-29 03:58:05 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140897 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 03:58:05.771785) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 03:58:05.772144) ========= 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=836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018039 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 03:58:05.825475) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 03:58:05.825868) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 9811b75c23b96078bb698e6949ca91b1adc4c95e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 9811b75c23b96078bb698e6949ca91b1adc4c95e --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=836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 03:58:06,062 truncating revision to first 12 chars 2016-06-29 03:58:06,062 Setting DEBUG logging. 2016-06-29 03:58:06,062 attempt 1/10 2016-06-29 03:58:06,062 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/9811b75c23b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 03:58:06,913 unpacking tar archive at: autoland-9811b75c23b9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.195721 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 03:58:07.043182) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 03:58:07.043556) ========= script_repo_revision: 9811b75c23b96078bb698e6949ca91b1adc4c95e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 03:58:07.044013) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 03:58:07.044334) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 03:58:07.054679) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-29 03:58:07.055018) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:58:07 INFO - MultiFileLogger online at 20160629 03:58:07 in /builds/slave/test 03:58:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 03:58:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:58:07 INFO - {'append_to_log': False, 03:58:07 INFO - 'base_work_dir': '/builds/slave/test', 03:58:07 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 03:58:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:58:07 INFO - 'branch': 'Autoland-Non-PGO', 03:58:07 INFO - 'buildbot_json_path': 'buildprops.json', 03:58:07 INFO - 'config_files': ('talos/linux_config.py',), 03:58:07 INFO - 'default_actions': ('clobber', 03:58:07 INFO - 'read-buildbot-config', 03:58:07 INFO - 'download-and-extract', 03:58:07 INFO - 'populate-webroot', 03:58:07 INFO - 'create-virtualenv', 03:58:07 INFO - 'install', 03:58:07 INFO - 'run-tests'), 03:58:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:58:07 INFO - 'download_minidump_stackwalk': True, 03:58:07 INFO - 'download_symbols': 'ondemand', 03:58:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:58:07 INFO - 'tooltool.py': '/tools/tooltool.py', 03:58:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:58:07 INFO - '/tools/misc-python/virtualenv.py')}, 03:58:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:58:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:58:07 INFO - 'installer_path': 'installer.exe', 03:58:07 INFO - 'log_level': 'info', 03:58:07 INFO - 'log_name': 'talos', 03:58:07 INFO - 'log_to_console': True, 03:58:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:58:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:58:07 INFO - 'opt_config_files': (), 03:58:07 INFO - 'pip_index': False, 03:58:07 INFO - 'sps_profile': False, 03:58:07 INFO - 'sps_profile_interval': 0, 03:58:07 INFO - 'suite': 'dromaeojs', 03:58:07 INFO - 'system_bits': '32', 03:58:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:58:07 INFO - 'title': 'talos-linux64-ix-028', 03:58:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:58:07 INFO - 'use_talos_json': True, 03:58:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:58:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:58:07 INFO - 'work_dir': 'build'} 03:58:07 INFO - ##### 03:58:07 INFO - ##### Running clobber step. 03:58:07 INFO - ##### 03:58:07 INFO - Running pre-action listener: _resource_record_pre_action 03:58:07 INFO - Running main action method: clobber 03:58:07 INFO - rmtree: /builds/slave/test/build 03:58:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:58:07 INFO - Running post-action listener: _resource_record_post_action 03:58:07 INFO - ##### 03:58:07 INFO - ##### Finished clobber step (success) 03:58:07 INFO - ##### 03:58:07 INFO - ##### 03:58:07 INFO - ##### Running read-buildbot-config step. 03:58:07 INFO - ##### 03:58:07 INFO - Running pre-action listener: _resource_record_pre_action 03:58:07 INFO - Running main action method: read_buildbot_config 03:58:07 INFO - Using buildbot properties: 03:58:07 INFO - { 03:58:07 INFO - "project": "", 03:58:07 INFO - "product": "firefox", 03:58:07 INFO - "script_repo_revision": "production", 03:58:07 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 03:58:07 INFO - "repository": "", 03:58:07 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 03:58:07 INFO - "buildid": "20160629024426", 03:58:07 INFO - "pgo_build": "False", 03:58:07 INFO - "basedir": "/builds/slave/test", 03:58:07 INFO - "buildnumber": 13, 03:58:07 INFO - "slavename": "talos-linux64-ix-028", 03:58:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:58:07 INFO - "platform": "ubuntu64_hw", 03:58:07 INFO - "scheduler": "tests-autoland-linux64-talos", 03:58:07 INFO - "branch": "autoland", 03:58:07 INFO - "repo_path": "integration/autoland", 03:58:07 INFO - "revision": "9811b75c23b96078bb698e6949ca91b1adc4c95e", 03:58:07 INFO - "stage_platform": "linux64", 03:58:07 INFO - "builduid": "c4b2b1ffda9647cf82fd357451c1dbc0", 03:58:07 INFO - "slavebuilddir": "test" 03:58:07 INFO - } 03:58:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:58:07 INFO - Running post-action listener: _resource_record_post_action 03:58:07 INFO - ##### 03:58:07 INFO - ##### Finished read-buildbot-config step (success) 03:58:07 INFO - ##### 03:58:07 INFO - ##### 03:58:07 INFO - ##### Running download-and-extract step. 03:58:07 INFO - ##### 03:58:07 INFO - Running pre-action listener: _resource_record_pre_action 03:58:07 INFO - Running main action method: download_and_extract 03:58:07 INFO - mkdir: /builds/slave/test/build/tests 03:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:07 INFO - https://queue.taskcluster.net/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:58:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:58:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:58:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dCXgivXgSVOHMG8CRRiZ1A/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 03:58:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dCXgivXgSVOHMG8CRRiZ1A/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 03:58:08 INFO - Downloaded 1361 bytes. 03:58:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:58:08 INFO - Using the following test package requirements: 03:58:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:58:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:58:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:58:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:08 INFO - u'jsshell-linux-x86_64.zip'], 03:58:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:58:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:58:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:58:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:58:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:58:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:58:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:08 INFO - https://queue.taskcluster.net/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:58:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:58:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:58:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dCXgivXgSVOHMG8CRRiZ1A/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 03:58:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dCXgivXgSVOHMG8CRRiZ1A/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 03:58:10 INFO - Downloaded 22700078 bytes. 03:58:10 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'] 03:58:10 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 03:58:11 INFO - Return code: 0 03:58:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:11 INFO - https://queue.taskcluster.net/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:58:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:58:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:58:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dCXgivXgSVOHMG8CRRiZ1A/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 03:58:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dCXgivXgSVOHMG8CRRiZ1A/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 03:58:13 INFO - Downloaded 22700078 bytes. 03:58:13 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'] 03:58:13 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 03:58:14 INFO - Return code: 0 03:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:14 INFO - https://queue.taskcluster.net/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:58:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:58:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:58:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dCXgivXgSVOHMG8CRRiZ1A/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 03:58:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dCXgivXgSVOHMG8CRRiZ1A/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 03:58:15 INFO - Downloaded 14405245 bytes. 03:58:15 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'] 03:58:15 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 03:58:15 INFO - Return code: 0 03:58: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')]} 03:58:15 INFO - https://queue.taskcluster.net/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:58:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:58:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:58:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dCXgivXgSVOHMG8CRRiZ1A/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 03:58:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dCXgivXgSVOHMG8CRRiZ1A/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 03:58:17 INFO - Downloaded 56437435 bytes. 03:58:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:58:17 INFO - mkdir: /builds/slave/test/properties 03:58:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:58:17 INFO - Writing to file /builds/slave/test/properties/build_url 03:58:17 INFO - Contents: 03:58:17 INFO - build_url:https://queue.taskcluster.net/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:58:18 INFO - Running post-action listener: _resource_record_post_action 03:58:18 INFO - Running post-action listener: set_extra_try_arguments 03:58:18 INFO - ##### 03:58:18 INFO - ##### Finished download-and-extract step (success) 03:58:18 INFO - ##### 03:58:18 INFO - ##### 03:58:18 INFO - ##### Running populate-webroot step. 03:58:18 INFO - ##### 03:58:18 INFO - Running pre-action listener: _resource_record_pre_action 03:58:18 INFO - Running main action method: populate_webroot 03:58:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:58:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:58:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:58:18 INFO - '--tppagecycles', 03:58:18 INFO - '7'], 03:58:18 INFO - 'tests': ['tsvgm']}}, 03:58:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:58:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:58:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:58:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:58:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:58:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:58:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:18 INFO - 'talos_options': ['--disable-e10s'], 03:58:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:58:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:58:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:18 INFO - 'talos_options': ['--disable-e10s'], 03:58:18 INFO - 'tests': ['damp', 'tps']}, 03:58:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:18 INFO - 'tests': ['damp', 'tps']}, 03:58:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:58:18 INFO - 'tests': ['dromaeo_dom']}, 03:58:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:58:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:58:18 INFO - 'tests': ['basic_compositor_video']}, 03:58:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:58:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:58:18 INFO - 'tests': ['a11yr', 03:58:18 INFO - 'ts_paint', 03:58:18 INFO - 'tpaint', 03:58:18 INFO - 'sessionrestore', 03:58:18 INFO - 'sessionrestore_no_auto_restore', 03:58:18 INFO - 'tabpaint']}, 03:58:18 INFO - 'other-e10s': {'tests': ['a11yr', 03:58:18 INFO - 'ts_paint', 03:58:18 INFO - 'tpaint', 03:58:18 INFO - 'sessionrestore', 03:58:18 INFO - 'sessionrestore_no_auto_restore', 03:58:18 INFO - 'tabpaint']}, 03:58:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:58:18 INFO - 'ts_paint', 03:58:18 INFO - 'tpaint', 03:58:18 INFO - 'sessionrestore', 03:58:18 INFO - 'sessionrestore_no_auto_restore', 03:58:18 INFO - 'tabpaint']}, 03:58:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:58:18 INFO - 'ts_paint', 03:58:18 INFO - 'tpaint', 03:58:18 INFO - 'sessionrestore', 03:58:18 INFO - 'sessionrestore_no_auto_restore', 03:58:18 INFO - 'tabpaint']}, 03:58:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:58:18 INFO - 'tests': ['a11yr', 03:58:18 INFO - 'ts_paint', 03:58:18 INFO - 'tpaint', 03:58:18 INFO - 'sessionrestore', 03:58:18 INFO - 'sessionrestore_no_auto_restore', 03:58:18 INFO - 'tabpaint']}, 03:58:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:58:18 INFO - 'tests': ['a11yr', 03:58:18 INFO - 'ts_paint', 03:58:18 INFO - 'tpaint', 03:58:18 INFO - 'sessionrestore', 03:58:18 INFO - 'sessionrestore_no_auto_restore', 03:58:18 INFO - 'tabpaint']}, 03:58:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:58:18 INFO - 'tests': ['tsvgx', 03:58:18 INFO - 'tsvgr_opacity', 03:58:18 INFO - 'tart', 03:58:18 INFO - 'tscrollx', 03:58:18 INFO - 'cart']}, 03:58:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:58:18 INFO - 'tsvgr_opacity', 03:58:18 INFO - 'tart', 03:58:18 INFO - 'tscrollx', 03:58:18 INFO - 'cart']}, 03:58:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:18 INFO - 'talos_options': ['--disable-e10s'], 03:58:18 INFO - 'tests': ['tp5o']}, 03:58:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:18 INFO - 'tests': ['tp5o']}, 03:58:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:18 INFO - 'talos_options': ['--disable-e10s', 03:58:18 INFO - '--xperf_path', 03:58:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:58:18 INFO - 'tests': ['tp5n']}, 03:58:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:18 INFO - 'talos_options': ['--xperf_path', 03:58:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:58:18 INFO - 'tests': ['tp5n']}}, 03:58:18 INFO - 'talos.zip': {'path': '', 03:58:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:58:18 INFO - Running post-action listener: _resource_record_post_action 03:58:18 INFO - ##### 03:58:18 INFO - ##### Finished populate-webroot step (success) 03:58:18 INFO - ##### 03:58:18 INFO - ##### 03:58:18 INFO - ##### Running create-virtualenv step. 03:58:18 INFO - ##### 03:58:18 INFO - Running pre-action listener: _resource_record_pre_action 03:58:18 INFO - Running main action method: create_virtualenv 03:58:18 INFO - Creating virtualenv /builds/slave/test/build/venv 03:58:18 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 03:58:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:58:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:58:18 INFO - Using real prefix '/usr' 03:58:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:58:19 INFO - Installing distribute.............................................................................................................................................................................................done. 03:58:21 INFO - Installing pip.................done. 03:58:21 INFO - Return code: 0 03:58:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:58: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')]} 03:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58: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')]} 03:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:21 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 0x252a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e93b0>, '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 0x27ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ea740>, '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': '836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653', '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 03:58:21 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 03:58:21 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 03:58:21 INFO - Using env: {'DISPLAY': ':0', 03:58:21 INFO - 'HOME': '/home/cltbld', 03:58:21 INFO - 'LANG': 'en_US.UTF-8', 03:58:21 INFO - 'LANGUAGE': 'en_US:en', 03:58:21 INFO - 'LOGNAME': 'cltbld', 03:58:21 INFO - 'MAIL': '/var/mail/cltbld', 03:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:21 INFO - 'MOZ_NO_REMOTE': '1', 03:58:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:21 INFO - 'NO_EM_RESTART': '1', 03:58:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:21 INFO - 'PWD': '/builds/slave/test', 03:58:21 INFO - 'SHELL': '/bin/bash', 03:58:21 INFO - 'SHLVL': '1', 03:58:21 INFO - 'TERM': 'linux', 03:58:21 INFO - 'TMOUT': '86400', 03:58:21 INFO - 'USER': 'cltbld', 03:58:21 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653', 03:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:21 INFO - '_': '/tools/buildbot/bin/python'} 03:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:21 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 03:58:21 INFO - Cleaning up... 03:58:21 INFO - Return code: 0 03:58:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:58: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')]} 03:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58: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')]} 03:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:21 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 0x252a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e93b0>, '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 0x27ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ea740>, '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': '836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653', '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 03:58:21 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 03:58:21 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 03:58:21 INFO - Using env: {'DISPLAY': ':0', 03:58:21 INFO - 'HOME': '/home/cltbld', 03:58:21 INFO - 'LANG': 'en_US.UTF-8', 03:58:21 INFO - 'LANGUAGE': 'en_US:en', 03:58:21 INFO - 'LOGNAME': 'cltbld', 03:58:21 INFO - 'MAIL': '/var/mail/cltbld', 03:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:21 INFO - 'MOZ_NO_REMOTE': '1', 03:58:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:21 INFO - 'NO_EM_RESTART': '1', 03:58:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:21 INFO - 'PWD': '/builds/slave/test', 03:58:21 INFO - 'SHELL': '/bin/bash', 03:58:21 INFO - 'SHLVL': '1', 03:58:21 INFO - 'TERM': 'linux', 03:58:21 INFO - 'TMOUT': '86400', 03:58:21 INFO - 'USER': 'cltbld', 03:58:21 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653', 03:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:21 INFO - '_': '/tools/buildbot/bin/python'} 03:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:21 INFO - Downloading/unpacking psutil>=3.1.1 03:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:58:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:58:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:58:23 INFO - Installing collected packages: psutil 03:58:23 INFO - Running setup.py install for psutil 03:58:23 INFO - building 'psutil._psutil_linux' extension 03:58:23 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 03:58:23 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 03:58:23 INFO - building 'psutil._psutil_posix' extension 03:58:23 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 03:58:23 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 03:58:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:58:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:58:24 INFO - Successfully installed psutil 03:58:24 INFO - Cleaning up... 03:58:24 INFO - Return code: 0 03:58:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:58:24 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')]} 03:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:24 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')]} 03:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:24 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 0x252a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e93b0>, '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 0x27ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ea740>, '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': '836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653', '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 03:58:24 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 03:58:24 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 03:58:24 INFO - Using env: {'DISPLAY': ':0', 03:58:24 INFO - 'HOME': '/home/cltbld', 03:58:24 INFO - 'LANG': 'en_US.UTF-8', 03:58:24 INFO - 'LANGUAGE': 'en_US:en', 03:58:24 INFO - 'LOGNAME': 'cltbld', 03:58:24 INFO - 'MAIL': '/var/mail/cltbld', 03:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:24 INFO - 'MOZ_NO_REMOTE': '1', 03:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:24 INFO - 'NO_EM_RESTART': '1', 03:58:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:24 INFO - 'PWD': '/builds/slave/test', 03:58:24 INFO - 'SHELL': '/bin/bash', 03:58:24 INFO - 'SHLVL': '1', 03:58:24 INFO - 'TERM': 'linux', 03:58:24 INFO - 'TMOUT': '86400', 03:58:24 INFO - 'USER': 'cltbld', 03:58:24 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653', 03:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:24 INFO - '_': '/tools/buildbot/bin/python'} 03:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:58:24 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 03:58:24 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 03:58:24 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 03:58:24 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 03:58:24 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 03:58:24 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 03:58:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:58:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:58:26 INFO - Installing collected packages: mozsystemmonitor 03:58:26 INFO - Running setup.py install for mozsystemmonitor 03:58:26 INFO - Successfully installed mozsystemmonitor 03:58:26 INFO - Cleaning up... 03:58:26 INFO - Return code: 0 03:58:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:26 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 0x252a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e93b0>, '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 0x27ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ea740>, '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': '836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653', '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 03:58:26 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 03:58:26 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 03:58:26 INFO - Using env: {'DISPLAY': ':0', 03:58:26 INFO - 'HOME': '/home/cltbld', 03:58:26 INFO - 'LANG': 'en_US.UTF-8', 03:58:26 INFO - 'LANGUAGE': 'en_US:en', 03:58:26 INFO - 'LOGNAME': 'cltbld', 03:58:26 INFO - 'MAIL': '/var/mail/cltbld', 03:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:26 INFO - 'MOZ_NO_REMOTE': '1', 03:58:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:26 INFO - 'NO_EM_RESTART': '1', 03:58:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:26 INFO - 'PWD': '/builds/slave/test', 03:58:26 INFO - 'SHELL': '/bin/bash', 03:58:26 INFO - 'SHLVL': '1', 03:58:26 INFO - 'TERM': 'linux', 03:58:26 INFO - 'TMOUT': '86400', 03:58:26 INFO - 'USER': 'cltbld', 03:58:26 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653', 03:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:26 INFO - '_': '/tools/buildbot/bin/python'} 03:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:26 INFO - Downloading/unpacking jsonschema==2.5.1 03:58:26 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 03:58:26 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 03:58:26 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 03:58:26 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 03:58:26 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 03:58:26 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 03:58:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:58:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:58: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 03:58: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 03:58: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 03:58: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 03:58: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 03:58: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 03:58:28 INFO - Downloading functools32-3.2.3-2.tar.gz 03:58:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:58:28 INFO - warning: no files found matching '*.txt' 03:58:28 INFO - no previously-included directories found matching 'build' 03:58:28 INFO - no previously-included directories found matching 'dist' 03:58:28 INFO - no previously-included directories found matching '.git*' 03:58:28 INFO - Installing collected packages: jsonschema, functools32 03:58:28 INFO - Running setup.py install for functools32 03:58:28 INFO - warning: no files found matching '*.txt' 03:58:28 INFO - no previously-included directories found matching 'build' 03:58:28 INFO - no previously-included directories found matching 'dist' 03:58:28 INFO - no previously-included directories found matching '.git*' 03:58:28 INFO - Successfully installed jsonschema functools32 03:58:28 INFO - Cleaning up... 03:58:29 INFO - Return code: 0 03:58:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:58:29 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')]} 03:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:29 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')]} 03:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:29 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 0x252a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e93b0>, '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 0x27ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ea740>, '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': '836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653', '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 03:58:29 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 03:58:29 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 03:58:29 INFO - Using env: {'DISPLAY': ':0', 03:58:29 INFO - 'HOME': '/home/cltbld', 03:58:29 INFO - 'LANG': 'en_US.UTF-8', 03:58:29 INFO - 'LANGUAGE': 'en_US:en', 03:58:29 INFO - 'LOGNAME': 'cltbld', 03:58:29 INFO - 'MAIL': '/var/mail/cltbld', 03:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:29 INFO - 'MOZ_NO_REMOTE': '1', 03:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:29 INFO - 'NO_EM_RESTART': '1', 03:58:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:29 INFO - 'PWD': '/builds/slave/test', 03:58:29 INFO - 'SHELL': '/bin/bash', 03:58:29 INFO - 'SHLVL': '1', 03:58:29 INFO - 'TERM': 'linux', 03:58:29 INFO - 'TMOUT': '86400', 03:58:29 INFO - 'USER': 'cltbld', 03:58:29 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653', 03:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:29 INFO - '_': '/tools/buildbot/bin/python'} 03:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:29 INFO - Downloading/unpacking blobuploader==1.2.4 03:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:31 INFO - Downloading blobuploader-1.2.4.tar.gz 03:58:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:58:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:58:31 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 03:58:31 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 03:58:31 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 03:58:31 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 03:58:31 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 03:58:31 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 03:58:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:58:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:58:31 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 03:58:31 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 03:58:31 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 03:58:31 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 03:58:31 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 03:58:31 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 03:58:31 INFO - Downloading docopt-0.6.1.tar.gz 03:58:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:58:31 INFO - Installing collected packages: blobuploader, requests, docopt 03:58:31 INFO - Running setup.py install for blobuploader 03:58:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:58:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:58:32 INFO - Running setup.py install for requests 03:58:32 INFO - Running setup.py install for docopt 03:58:32 INFO - Successfully installed blobuploader requests docopt 03:58:32 INFO - Cleaning up... 03:58:32 INFO - Return code: 0 03:58:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:58: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')]} 03:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58: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')]} 03:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:32 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 0x252a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e93b0>, '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 0x27ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ea740>, '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': '836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653', '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 03:58:32 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 03:58:32 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 03:58:32 INFO - Using env: {'DISPLAY': ':0', 03:58:32 INFO - 'HOME': '/home/cltbld', 03:58:32 INFO - 'LANG': 'en_US.UTF-8', 03:58:32 INFO - 'LANGUAGE': 'en_US:en', 03:58:32 INFO - 'LOGNAME': 'cltbld', 03:58:32 INFO - 'MAIL': '/var/mail/cltbld', 03:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:32 INFO - 'MOZ_NO_REMOTE': '1', 03:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:32 INFO - 'NO_EM_RESTART': '1', 03:58:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:32 INFO - 'PWD': '/builds/slave/test', 03:58:32 INFO - 'SHELL': '/bin/bash', 03:58:32 INFO - 'SHLVL': '1', 03:58:32 INFO - 'TERM': 'linux', 03:58:32 INFO - 'TMOUT': '86400', 03:58:32 INFO - 'USER': 'cltbld', 03:58:32 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653', 03:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:32 INFO - '_': '/tools/buildbot/bin/python'} 03:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:58:32 INFO - Running setup.py (path:/tmp/pip-w91PHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:58:32 INFO - Running setup.py (path:/tmp/pip-B_dog0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:58:32 INFO - Running setup.py (path:/tmp/pip-o5Tzg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:58:32 INFO - Running setup.py (path:/tmp/pip-V7pP7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:58:33 INFO - Running setup.py (path:/tmp/pip-q05SyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:58:33 INFO - Running setup.py (path:/tmp/pip-YSUbFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:58:33 INFO - Running setup.py (path:/tmp/pip-0dD0Sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:58:33 INFO - Running setup.py (path:/tmp/pip-wUR0jh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:58:33 INFO - Running setup.py (path:/tmp/pip-LHjRv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:58:33 INFO - Running setup.py (path:/tmp/pip-101FV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:58:33 INFO - Running setup.py (path:/tmp/pip-1tUQOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:58:33 INFO - Running setup.py (path:/tmp/pip-dz_GaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:58:33 INFO - Running setup.py (path:/tmp/pip-TeLYTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:58:33 INFO - Running setup.py (path:/tmp/pip-PXJlUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:33 INFO - Running setup.py (path:/tmp/pip-wPWYqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:58:33 INFO - Running setup.py (path:/tmp/pip-wTyJ7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:58:33 INFO - Running setup.py (path:/tmp/pip-KuYgpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:58:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:58:33 INFO - Running setup.py install for manifestparser 03:58:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:58:34 INFO - Running setup.py install for mozcrash 03:58:34 INFO - Running setup.py install for mozdebug 03:58:34 INFO - Running setup.py install for mozdevice 03:58:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:58:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:58:34 INFO - Running setup.py install for mozfile 03:58:34 INFO - Running setup.py install for mozhttpd 03:58:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:58:34 INFO - Running setup.py install for mozinfo 03:58:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:58:34 INFO - Running setup.py install for mozInstall 03:58:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:58:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:58:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:58:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:58:34 INFO - Running setup.py install for mozleak 03:58:34 INFO - Running setup.py install for mozlog 03:58:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:58:34 INFO - Running setup.py install for moznetwork 03:58:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:58:35 INFO - Running setup.py install for mozprocess 03:58:35 INFO - Running setup.py install for mozprofile 03:58:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:58:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:58:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:58:35 INFO - Running setup.py install for mozrunner 03:58:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:58:35 INFO - Running setup.py install for mozscreenshot 03:58:35 INFO - Running setup.py install for moztest 03:58:35 INFO - Running setup.py install for mozversion 03:58:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:58:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:58:35 INFO - Cleaning up... 03:58:35 INFO - Return code: 0 03:58:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:58: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')]} 03:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58: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')]} 03:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:35 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 0x252a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e93b0>, '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 0x27ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ea740>, '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': '836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653', '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 03:58:35 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 03:58:35 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 03:58:35 INFO - Using env: {'DISPLAY': ':0', 03:58:35 INFO - 'HOME': '/home/cltbld', 03:58:35 INFO - 'LANG': 'en_US.UTF-8', 03:58:35 INFO - 'LANGUAGE': 'en_US:en', 03:58:35 INFO - 'LOGNAME': 'cltbld', 03:58:35 INFO - 'MAIL': '/var/mail/cltbld', 03:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:35 INFO - 'MOZ_NO_REMOTE': '1', 03:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:35 INFO - 'NO_EM_RESTART': '1', 03:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:35 INFO - 'PWD': '/builds/slave/test', 03:58:35 INFO - 'SHELL': '/bin/bash', 03:58:35 INFO - 'SHLVL': '1', 03:58:35 INFO - 'TERM': 'linux', 03:58:35 INFO - 'TMOUT': '86400', 03:58:35 INFO - 'USER': 'cltbld', 03:58:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653', 03:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:35 INFO - '_': '/tools/buildbot/bin/python'} 03:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:58:35 INFO - Running setup.py (path:/tmp/pip-gt6yGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:58:36 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)) 03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:58:36 INFO - Running setup.py (path:/tmp/pip-9hP6Eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:58:36 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)) 03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:58:36 INFO - Running setup.py (path:/tmp/pip-zhKJCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:58:36 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)) 03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:58:36 INFO - Running setup.py (path:/tmp/pip-GyZE6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:58:36 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)) 03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:58:36 INFO - Running setup.py (path:/tmp/pip-l_oN9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:58:36 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)) 03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:58:36 INFO - Running setup.py (path:/tmp/pip-1_XOKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:58:36 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)) 03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:58:36 INFO - Running setup.py (path:/tmp/pip-YMQrGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:58:36 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)) 03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:58:36 INFO - Running setup.py (path:/tmp/pip-LC5QaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:58:36 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)) 03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:58:36 INFO - Running setup.py (path:/tmp/pip-KvDL7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:58:36 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)) 03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:58:36 INFO - Running setup.py (path:/tmp/pip-cfeueE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:58:36 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)) 03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:58:36 INFO - Running setup.py (path:/tmp/pip-ibmCXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:58:36 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)) 03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:58:36 INFO - Running setup.py (path:/tmp/pip-zm4uQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:58:36 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)) 03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:58:36 INFO - Running setup.py (path:/tmp/pip-oJeXj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:58:36 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)) 03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:58:36 INFO - Running setup.py (path:/tmp/pip-oDQAtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:58:36 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)) 03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:37 INFO - Running setup.py (path:/tmp/pip-4Yq_HB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:37 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)) 03:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:58:37 INFO - Running setup.py (path:/tmp/pip-EXQRq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:58:37 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)) 03:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:58:37 INFO - Running setup.py (path:/tmp/pip-4rFOfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:58:37 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)) 03:58:37 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)) 03:58:37 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)) 03:58:37 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)) 03:58:37 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)) 03:58:37 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)) 03:58:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:58: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 03:58: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 03:58: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 03:58: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 03:58: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 03:58: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 03:58:39 INFO - Downloading blessings-1.6.tar.gz 03:58:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:58:39 INFO - Installing collected packages: blessings 03:58:39 INFO - Running setup.py install for blessings 03:58:39 INFO - Successfully installed blessings 03:58:39 INFO - Cleaning up... 03:58:39 INFO - Return code: 0 03:58:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:58:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:58:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:58:39 INFO - Reading from file tmpfile_stdout 03:58:39 INFO - Current package versions: 03:58:39 INFO - argparse == 1.2.1 03:58:39 INFO - blessings == 1.6 03:58:39 INFO - blobuploader == 1.2.4 03:58:39 INFO - docopt == 0.6.1 03:58:39 INFO - functools32 == 3.2.3-2 03:58:39 INFO - jsonschema == 2.5.1 03:58:39 INFO - manifestparser == 1.1 03:58:39 INFO - mozInstall == 1.12 03:58:39 INFO - mozcrash == 0.17 03:58:39 INFO - mozdebug == 0.1 03:58:39 INFO - mozdevice == 0.48 03:58:39 INFO - mozfile == 1.2 03:58:39 INFO - mozhttpd == 0.7 03:58:39 INFO - mozinfo == 0.9 03:58:39 INFO - mozleak == 0.1 03:58:39 INFO - mozlog == 3.2 03:58:39 INFO - moznetwork == 0.27 03:58:39 INFO - mozprocess == 0.22 03:58:39 INFO - mozprofile == 0.28 03:58:39 INFO - mozrunner == 6.11 03:58:39 INFO - mozscreenshot == 0.1 03:58:39 INFO - mozsystemmonitor == 0.3 03:58:39 INFO - moztest == 0.7 03:58:39 INFO - mozversion == 1.4 03:58:39 INFO - psutil == 3.1.1 03:58:39 INFO - requests == 1.2.3 03:58:39 INFO - wsgiref == 0.1.2 03:58:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:58: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')]} 03:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58: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')]} 03:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:39 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 0x252a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e93b0>, '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 0x27ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ea740>, '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': '836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653', '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 03:58:39 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 03:58:39 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 03:58:39 INFO - Using env: {'DISPLAY': ':0', 03:58:39 INFO - 'HOME': '/home/cltbld', 03:58:39 INFO - 'LANG': 'en_US.UTF-8', 03:58:39 INFO - 'LANGUAGE': 'en_US:en', 03:58:39 INFO - 'LOGNAME': 'cltbld', 03:58:39 INFO - 'MAIL': '/var/mail/cltbld', 03:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:39 INFO - 'MOZ_NO_REMOTE': '1', 03:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:39 INFO - 'NO_EM_RESTART': '1', 03:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:39 INFO - 'PWD': '/builds/slave/test', 03:58:39 INFO - 'SHELL': '/bin/bash', 03:58:39 INFO - 'SHLVL': '1', 03:58:39 INFO - 'TERM': 'linux', 03:58:39 INFO - 'TMOUT': '86400', 03:58:39 INFO - 'USER': 'cltbld', 03:58:39 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653', 03:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:39 INFO - '_': '/tools/buildbot/bin/python'} 03:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:39 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)) 03:58:39 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)) 03:58:39 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)) 03:58:39 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)) 03:58:39 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)) 03:58:39 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)) 03:58:39 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)) 03:58:39 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)) 03:58:39 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)) 03:58:39 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)) 03:58:39 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)) 03:58:39 INFO - Cleaning up... 03:58:39 INFO - Return code: 0 03:58:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:58: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')]} 03:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58: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')]} 03:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:39 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 0x252a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e93b0>, '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 0x27ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ea740>, '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': '836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653', '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 03:58:39 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 03:58:39 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 03:58:39 INFO - Using env: {'DISPLAY': ':0', 03:58:39 INFO - 'HOME': '/home/cltbld', 03:58:39 INFO - 'LANG': 'en_US.UTF-8', 03:58:39 INFO - 'LANGUAGE': 'en_US:en', 03:58:39 INFO - 'LOGNAME': 'cltbld', 03:58:39 INFO - 'MAIL': '/var/mail/cltbld', 03:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:39 INFO - 'MOZ_NO_REMOTE': '1', 03:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:39 INFO - 'NO_EM_RESTART': '1', 03:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:39 INFO - 'PWD': '/builds/slave/test', 03:58:39 INFO - 'SHELL': '/bin/bash', 03:58:39 INFO - 'SHLVL': '1', 03:58:39 INFO - 'TERM': 'linux', 03:58:39 INFO - 'TMOUT': '86400', 03:58:39 INFO - 'USER': 'cltbld', 03:58:39 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653', 03:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:39 INFO - '_': '/tools/buildbot/bin/python'} 03:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:58:40 INFO - Cleaning up... 03:58:40 INFO - Return code: 0 03:58:40 INFO - Running post-action listener: _resource_record_post_action 03:58:40 INFO - Running post-action listener: _start_resource_monitoring 03:58:40 INFO - Starting resource monitoring. 03:58:40 INFO - ##### 03:58:40 INFO - ##### Finished create-virtualenv step (success) 03:58:40 INFO - ##### 03:58:40 INFO - ##### 03:58:40 INFO - ##### Running install step. 03:58:40 INFO - ##### 03:58:40 INFO - Running pre-action listener: _resource_record_pre_action 03:58:40 INFO - Running main action method: install 03:58:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:58:40 INFO - Reading from file tmpfile_stdout 03:58:40 INFO - Detecting whether we're running mozinstall >=1.0... 03:58:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:58:40 INFO - Reading from file tmpfile_stdout 03:58:40 INFO - Output received: 03:58:40 INFO - Usage: mozinstall [options] installer 03:58:40 INFO - Options: 03:58:40 INFO - -h, --help show this help message and exit 03:58:40 INFO - -d DEST, --destination=DEST 03:58:40 INFO - Directory to install application into. [default: 03:58:40 INFO - "/builds/slave/test"] 03:58:40 INFO - --app=APP Application being installed. [default: firefox] 03:58:40 INFO - mkdir: /builds/slave/test/build/application 03:58:40 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'] 03:58:40 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 03:58:56 INFO - Reading from file tmpfile_stdout 03:58:56 INFO - Output received: 03:58:56 INFO - /builds/slave/test/build/application/firefox/firefox 03:58:56 INFO - Running post-action listener: _resource_record_post_action 03:58:56 INFO - ##### 03:58:56 INFO - ##### Finished install step (success) 03:58:56 INFO - ##### 03:58:56 INFO - ##### 03:58:56 INFO - ##### Running run-tests step. 03:58:56 INFO - ##### 03:58:56 INFO - Running pre-action listener: _resource_record_pre_action 03:58:56 INFO - Running main action method: run_tests 03:58:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:58:56 INFO - Python 2.7.3 03:58:56 INFO - Return code: 0 03:58:56 INFO - grabbing minidump binary from tooltool 03:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:58:56 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 0x27e93b0>, '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 0x27ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ea740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:58:56 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 03:58:56 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 03:58:56 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 03:58:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:58:56 INFO - Return code: 0 03:58:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:58:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:58:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:58:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:58:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:58:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 03:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 03:58:56 INFO - Using env: {'DISPLAY': ':0', 03:58:56 INFO - 'HOME': '/home/cltbld', 03:58:56 INFO - 'LANG': 'en_US.UTF-8', 03:58:56 INFO - 'LANGUAGE': 'en_US:en', 03:58:56 INFO - 'LOGNAME': 'cltbld', 03:58:56 INFO - 'MAIL': '/var/mail/cltbld', 03:58:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:58:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:56 INFO - 'MOZ_NO_REMOTE': '1', 03:58:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:56 INFO - 'NO_EM_RESTART': '1', 03:58:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:56 INFO - 'PWD': '/builds/slave/test', 03:58:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:58:56 INFO - 'SHELL': '/bin/bash', 03:58:56 INFO - 'SHLVL': '1', 03:58:56 INFO - 'TERM': 'linux', 03:58:56 INFO - 'TMOUT': '86400', 03:58:56 INFO - 'USER': 'cltbld', 03:58:56 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653', 03:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:56 INFO - '_': '/tools/buildbot/bin/python'} 03:58:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 03:58:56 INFO - mozversion application_buildid: 20160629024426 03:58:56 INFO - mozversion application_changeset: 9811b75c23b96078bb698e6949ca91b1adc4c95e 03:58:56 INFO - mozversion application_display_name: Nightly 03:58:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:58:56 INFO - mozversion application_name: Firefox 03:58:56 INFO - mozversion application_remotingname: firefox 03:58:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:58:56 INFO - mozversion application_vendor: Mozilla 03:58:56 INFO - mozversion application_version: 50.0a1 03:58:56 INFO - mozversion platform_buildid: 20160629024426 03:58:56 INFO - mozversion platform_changeset: 9811b75c23b96078bb698e6949ca91b1adc4c95e 03:58:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:58:56 INFO - mozversion platform_version: 50.0a1 03:58:56 INFO - using testdate: 1467197936 03:58:56 INFO - actual date: 1467197936 03:58:56 INFO - starting webserver on 'localhost:56229' 03:58:56 INFO - SUITE-START | Running 2 tests 03:58:56 INFO - TEST-START | dromaeo_css 03:58:56 INFO - operating with platform_type : linux_ 03:58:56 INFO - Initialising browser for dromaeo_css test... 03:58:56 INFO - TEST-INFO | started process 29664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprcYnm9/profile http://localhost:56229/getInfo.html) 03:59:01 INFO - PROCESS | 29664 | __metrics Screen width/height:1600/1200 03:59:01 INFO - PROCESS | 29664 | colorDepth:24 03:59:01 INFO - PROCESS | 29664 | Browser inner width/height: 1024/697 03:59:01 INFO - PROCESS | 29664 | __metrics 03:59:02 INFO - PROCESS | 29664 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:59:03 INFO - TEST-INFO | 29664: exit 0 03:59:03 INFO - Browser initialized. 03:59:03 INFO - Running cycle 1/1 for dromaeo_css test... 03:59:03 INFO - TEST-INFO | started process 29746 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprcYnm9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:15 INFO - PROCESS | 29746 | RSS: Main: 158031872 03:59:15 INFO - PROCESS | 29746 | 04:00:06 INFO - PROCESS | 29746 | 1467198006848 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] 04:02:18 INFO - PROCESS | 29746 | Cycle 1(1): loaded http://localhost:56229/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56229/tests/dromaeo/cssquery-ext.html) 04:02:19 INFO - PROCESS | 29746 | RSS: Main: 244072448 04:02:19 INFO - PROCESS | 29746 | 04:05:22 INFO - PROCESS | 29746 | Cycle 1(1): loaded http://localhost:56229/tests/dromaeo/cssquery-ext.html (next: http://localhost:56229/tests/dromaeo/cssquery-jquery.html) 04:05:23 INFO - PROCESS | 29746 | RSS: Main: 238370816 04:05:23 INFO - PROCESS | 29746 | 04:08:25 INFO - PROCESS | 29746 | Cycle 1(1): loaded http://localhost:56229/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56229/tests/dromaeo/cssquery-mootools.html) 04:08:25 INFO - PROCESS | 29746 | RSS: Main: 241971200 04:08:25 INFO - PROCESS | 29746 | 04:11:28 INFO - PROCESS | 29746 | Cycle 1(1): loaded http://localhost:56229/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56229/tests/dromaeo/cssquery-prototype.html) 04:11:28 INFO - PROCESS | 29746 | RSS: Main: 232894464 04:11:28 INFO - PROCESS | 29746 | 04:14:31 INFO - PROCESS | 29746 | Cycle 1(1): loaded http://localhost:56229/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56229/tests/dromaeo/cssquery-yui.html) 04:14:32 INFO - PROCESS | 29746 | RSS: Main: 217501696 04:14:32 INFO - PROCESS | 29746 | 04:17:35 INFO - PROCESS | 29746 | Cycle 1(1): loaded http://localhost:56229/tests/dromaeo/cssquery-yui.html (next: http://localhost:56229/tests/dromaeo/cssquery-dojo.html) 04:17:35 INFO - PROCESS | 29746 | RSS: Main: 275800064 04:17:35 INFO - PROCESS | 29746 | 04:17:35 INFO - PROCESS | 29746 | __start_tp_report 04:17:35 INFO - PROCESS | 29746 | _x_x_mozilla_page_load 04:17:35 INFO - PROCESS | 29746 | _x_x_mozilla_page_load_details 04:17:35 INFO - PROCESS | 29746 | |i|pagename|runs| 04:17:35 INFO - PROCESS | 29746 | |0;dojo.html;2617.3849145450818;2619.5415802234606;2655.7609815116643;2661.188337557044;2663.081236973245;4530.818767249314;4603.539646035395;4617.722936623801;4683.531646835319;4713.693609915357;4673.602743766775;4673.929891051637;4675.50907154749;4704.600108990731;4710.246360582308;4074.30736774749;4217.641500472456;4312.654987600984;4344.4786625604975;4418.050119224366;4328.415663885383;4362.607365337119;4379.364992076147;4383.715058521186;4420.403245561856;4164.833406663745;4194.559571245037;4200.684948628865;4231.87304380869;4248.511421186572;4207.91584168318;4271.231178387889;4286.142771445723;4286.76422796746;4330.588594083557;4252.489701235841;4255.468066491689;4263.978680106579;4311.892202694927;4316.935245971313;4397.868063958054;4631.536846315342;4695.037517308943;4699.389079419653;4721.929171062402;4983.526564976321;4997.0505603935135;5000.574951129122;5012.72430016349;5026.497350264981;4878.951210487885;4948.158813001798;5030.195168773015;5052.166392545226;5054.039732450859;4658.4642766082;4725.4565724941385;4732.716037037789;4734.4081989751285;4736.123817093849;5144.562712169432;5169.198774190007;5173.301604283449;5175.534201921845;5177.58579313654;4791.425028996473;4894.11905856942;4896.2410826321975;4912.4350699669285;4959.677620954699;4996.500349964975;5031.974840125776;5042.672226305352;5053;5100.719460429712;4971.651984361132;4981.576565991859;4987.725675087905;5000.3249561309485;5036.949630503721;4819.807207711722;4917.680350777259;4946.159152944008;4988.90022199554;5039.874003149877;4181.080162364275;4181.728187667853;4186.539480657125;4202.474690663667;4225.767582782915;3656.670899619047;3678.0988657779017;3681.4661874028116;3710.851565937386;3727.552693676776;4279.229738647011;4331.696781225284;4376.912461750747;4401.493828209733;4415.249407600716;5019.071471777733;5060.898782024339;5063.518965698253;5072.213806859942;5102.923456148161;4410.779461027;4422.513523512411;4433.46798384196;4458.308962110878;4469.396631454777;4330.631896288788;4424.535423780521;4450.599446049871;4460.910781784346;4479.283314669638;4734.479207287264;4752.287156926489;4754.619630429626;4755.5719985201495;4808.0383923216195;5028.34631497903;5043.117454445384;5043.36957880265;5045.621578381562;5102.260172274925;4604.148232576984;4693;4723.740194289209;4743.739094349706;4751.714897106184;4911.656184067081;4933.728644924564;4950.430700469492;4954.083494553519;4993.6254780892305;4810.278458231293;4962.6774259673;5024.0956627807345;5026.44709082008;5061.9493805061475;4804.831830886042;4853.344798452164;4856.320115183807;4874.0495603357;4894.241392584155;4830.975845120752;4867.318575399376;4868.756562171948;4869.074875773592;4912;4658.534146585314;4791.089692958327;4807.326974223542;4828.66199366055;4879.536444037811;4924.679895806761;4942.975285123552;4955;4971.900561988812;5022.799088036438;4852.078105160008;4861.586765125004;4868.148074087091;4868.853934381974;4916.164252077084 04:17:35 INFO - PROCESS | 29746 | |1;ext.html;554.1757793676095;572.6850232372195;575.7351618255603;593.3858456497524;593.8159170657094;27650.723492765068;40380.394294085614;41222.17555648885;41357.759267222034;41377.79311103448;42086.789566052124;42515.36226956598;42534.78732606333;42600;42610.36084458728;7579.355754760852;7872.134065252818;7989.800254993643;7990.240927111944;10602.416867072308;10421.166306695446;10537.47312634369;10545.472726363689;10548;10548.525316360743;10550.577976880953;10593.73515662107;10595.046445819875;10600.310979786327;10607.416592087433;7432.739854105107;10280.640177593823;10479.685609431692;10562.996515331108;10574;10377.325473844252;10460.895391046068;10463.68608941733;10466.319689220252;10485.266031377807;39109;39513.81458556248;39548.60451395507;39579.20841583152;39618.80190599057;3168.7940283881703;3294.4234758917096;3419.880304189366;3549.4675798630155;3684.5394325709285;29790.70209297901;29800.701992980008;29980.55029174564;30095.398092038256;31101.377972440423;3607.981960090209;3643.8542458301636;3649.6897763690117;3652.543432070991;3748.812559372048;189998;190895;191108;191145.9999999986;191847;51901.7404912973;51915;52165.47834521682;52195.95608087893;52264.73867630713;33211;34293.314133717184;34330.73857983488;36024.639753602125;55766.44233557694;15180.240987950558;15317.157556334509;15356.769648455282;15368.462103826312;15374.692506150039;10498.317609355367;11291.3789741565;11660.708482288012;11702.88297117035;11910.761784764256;18311.359102431616;18460.446186614423;18476.630467390576;18478.353257635918;18479.53801154955;6599.73601055962;6727.865442691119;6782.389584937379;6944.652767361612;7020.192677842114;832.8292699996487;884.3676771108688;906.1663269791808;912.8356895758827;996.0885789502524;26539;28574.571381429294;28780.42439151247;28823.2794180143;28920.710792892223;950.5579905344048;978.8825340958988;990.0643891522586;1017.6164253855959;1087.141158484788;15018.849811501745;15042.473513426978;15123.31945062475;15235.3905843765;15247.23763811805;383142;388914;389631;389700;392678;50403.49596503988;50665.49334506682;51017.48982510201;51105.74447127741;51119.48880511222;1099.2689861242345;1184.4281075050299;1198.3229475346575;1207.185150023748;1233.5805826019196;28461.715382846734;29250.853745731136;29577.704222958357;29630.703692962794;30220.24449388783;42500.36249456199;42523.574764251964;43073.7846310779;43114.353284701385;43137.13725725531;305867;307038;307370;308066;308563;22367.217147399762;24612.261632151065;25607.743922560538;25994;26981.595276070482;41854.37218441665;41935.37096943487;41953.790231048646;42689;42874.35688464738;35314.11714707153;36124.638753612126;36704.81647591852;36737.26525469422;36779.26441471209;35735.46396804102;36381;36404;36463.635363646026;36756.44865327076;34805.825970869984;35659.10852228715;36173.27653446969;36286.63713362833;36398.8180059098;30803.69196308098;32471.512927305637;33028.83485582557;33086;33147.66852331446;24474.632880507164;25303.74696253014;25315.493690126463;25322.366940826625;25611.231663050137 04:17:35 INFO - PROCESS | 29746 | |2;jquery.html;340.754656647214;346.3367650948434;347.8017530007895;355.8238671857431;362.6572888620253;16220.432284870032;17548.82451175488;17813.198406071726;17828;17848.553786155335;15747.60630984226;16338.34646614134;16632.33470661172;16632.66734665306;16633.916830415863;4932.432770231433;5110.412302585213;5146.639735218536;5160.045391602547;5162.045021671003;3762.6613604775566;3940.113474468236;5059.468755780646;5756.913646295309;6070.757169713228;6063.242094738158;6107.206063211798;6131.049687298476;6142.662153581551;6146.969265153691;5842.444967728059;6029.306629737593;6031.939680603182;6034.939650603482;6039.033754599265;3345.8159801210923;4886.218205087169;5194.766235519411;5196.68819870809;5199.220116982445;20567.485812854797;21318.46703832401;21348.146074157172;21486.35540933759;21535;1906.4090132059107;1980.4751740788702;2013.6979453082008;2145.2598853395552;2448.069733501276;8913.643454261823;9279.675211367638;11841.822372664417;12124;13437.395317210749;1697.4398448512086;1714.7856517935259;1744.5376975101608;1764.6117854072083;1784.4200634793744;69872;70117.29882701108;70557.64721176412;71196.28803711948;72627;9491.715248542554;9495.90504094964;9512.191463725523;9654.469004204695;9722.61109555624;12772;12801.01584254442;12876.613701588967;12879.549215777402;12884.098113131991;7233.095863017123;7237.312455316736;7323.670434830446;7330.96334518324;7525.397968162534;7166.964165179141;7189.281071892873;7308.37878780299;7389;7396.038514993016;4089.3048181809163;4113.835446582103;4126.91746165081;4132.152908653718;4231.513375961742;1595.2422599265255;1603.9475651697014;1713.4773893962213;1731.342090005815;1743.450812993903;810.9837803243902;858.3305022082785;876.6668665906915;931.2038207332633;953.5994882149514;16157.59606009859;16900.83099169017;17052.403165889133;17124.633218529194;17437.51781098621;861.9784505387415;869.3566760597113;881.4314766975265;903.1510380242551;919.558611866308;9428.340016198801;9856.008316631633;9882.752931176778;9883.258755593359;10010.299279050541;402107;405814;416020;417985;418701;74025.25974740292;75755.24244757592;75913;76153.61923190349;76296.61851690817;905.0994260710635;905.1401168889581;918.2149262380702;932.7621456528677;938.591712605019;15290.617734556725;15330.233488325763;15407;15578.376864925276;15846.60383490422;36100.09749756277;37375.252494950495;37702.43446348252;38530;38593.614063859;50779.238311426096;51804.740976294874;52084.21873671822;52745.47254527405;53052.469475306294;7230.240824713329;7633.580153091633;7682.270184332479;7734.149243583089;7839.432113577422;11807.291562506278;12034.277943323428;12040.337781422106;12207.511699531919;12256.816147757612;9885.258605604753;9922.107010369102;10021.448820314952;10048.296619236584;10170.288079834341;10512.26414151002;10651.30766500175;10681.252312338373;10700.678979630624;10806.18953578469;10218;10321.380717156995;10378.481075946323;10537.42044187577;10586.576536938435;7460;7569.5079819811535;7579;7637.732679356196;7714.6914123434435;7977.880331795144;9817.165540929102;9916.504174791087;10044.748881277734;10178.847317290394 04:17:35 INFO - PROCESS | 29746 | |3;mootools.html;1215.0401183065378;1356.4099616666747;1403.936822842972;1455.7234125516152;1660.9169541522922;6492.870142597145;7377.4466914981385;7633.46565740397;7635.656395462203;7860.371170306362;7553.773386798391;7746.264104910038;7749.225077492248;7752.651130699118;7752.7674169775;2159.762426133128;2193.8135258502966;2198.2525941179997;2199.3621849663577;2199.736031676201;2157.590057889004;2188.9562208755815;2192.6710993350966;2193.594185075758;2196.176433837311;2151.8924053797327;2155.5796619659172;2158.956820863582;2167.945801354963;2202.4383782135615;2129.361191642509;2134.7438307403054;2135.1566131378017;2135.9786402136015;2136.177571634916;2072.678734796109;2126.8723876567456;2129.7337832770904;2130.7975742304457;2131.7761635028255;7534.886976695299;7643.273888980538;7754.418418618626;7774.144844067148;7775.961120194419;4569.611583015448;4687.460941991646;4689.484156742756;4690.788914498856;4693.084848454553;2796.3288810685494;2958.7189217024347;3002.804817686865;3009.0521485732143;3019.9245018874485;965.2374624046995;969.2972594868734;986.2997271936933;988.0712130597287;992.1913640383137;10170.338927969658;10290.845637315446;10306.639267625673;10316.1747060235;10317.226208034352;3981.9845939285296;4000.9399859002137;4078.0824314528995;4084.9583356243966;4088.9182216355507;8249.216324449288;8290.917090829134;8317.085120636724;8317.126701696356;8322.833543329221;4549.954500455019;4551.271796512542;4552.453705555355;4552.635789136861;4555.681102322872;3613.837377318027;3781.035835861893;4002.5597184309704;4063.227986682521;4235.4917409910395;3304.3721692878275;3309.2885029718727;3384.6784555467193;3391.983040084833;3393.3891899458336;950.9619615215453;998.7602975285879;1000.7648202672366;1003.0420947994647;1005.6480231918916;705.7212401101639;795.363709032783;835.2232423845882;836.506461187902;840.369722707969;4940.086084074458;5068.518490743373;5078.035173317058;5162.148245539519;5198.2722418861385;826.1201820061615;871.5729292646557;899.150302963706;901.1439132823843;903.5256490342623;3384.593848738118;3561.269939662363;3561.661642144044;3568.9643103568633;3658.689011434005;9218.53907304632;9348.345615806827;9543.236541076698;9547.188488978514;9559;9406.200472959737;9408.43549387039;9413.670521531714;9419.152276295166;9422.90577094234;6926.272741362185;7209.639518024078;7209.71161153548;7212.927870721331;7366.889496657554;5121.641485096007;5122.206058061007;5122.282880396673;5141.434442211279;5267.104592219255;8480.575971201539;8644.308455323684;8647.956760216159;8688.435251708619;8746.65013399457;8564.614592343234;8709.956450217709;8753.387262891536;8791.956040219759;8928.10718928128;5989.161517387656;6035.36628653985;6120.296165940796;6179.536534759821;6289.842753931189;7309.744158954411;7617.69529218825;7625.123110842324;7625.23747625233;7638.388928885564;6631.834204144742;6861.2795656455355;6866.244713081457;6888.448924085961;6912.170539535288;6454.322296158835;6537.182852143482;6751.527393082633;6780.186377634715;6927.6882540286815;5946.494547963472;6024.367441418588;6044.063170208625;6055.333913269625;6055.939440605714;4385.561443855589;4424.048829501673;4609.907801843878;4622.745748983838;4642.466116396523;4394.252976993983;4460.085682435158;4473;4487.910241795211;4529.886752831206 04:17:35 INFO - PROCESS | 29746 | |4;prototype.html;285.708616892522;285.9771218302536;287.4524031719574;291.96642386125603;292.1454744871251;4878.365812444382;4896.9961157962625;4902.259697807276;4902.8774280643;4972.2293044578055;4748.240281554952;4752;4811.13399588074;4876.512348765122;4889.608831293497;3533.734969877263;3643.25313310772;3678.429843374281;3735.8879233623034;3777.112378591029;3718.4794128821986;3741.5884252732176;3744.794036328001;3765.698744100479;3767.9058023549355;3538.575370955489;3704.2776658551593;3710.2764960832646;3720.6465385788306;3738.756980796253;3622.9094272643133;3747.4940882980723;3750.4186851038135;3752.924941501168;3757.3236817372863;3299;3311.420501412243;3311.966880331214;3322.1196382958537;3326.9833650831833;4685.7657117144345;4728.739919304437;4728.952710472886;4750.667453278272;4758.476567577563;4186.225548273579;4280.657547396201;4310.202612516695;4330.2638551446325;4330.523642399365;5036.546710796046;5056.62075344347;5092.28707980883;5102.923456148161;5110.540051395392;3639.981800091009;3643.544556930384;3647.3434781739275;3658.756022952209;3660.9816950915074;5013.548780609763;5303.469653034705;5323;5324.653897496651;5361.839144825701;3562.946555801665;3584.2473080653353;3595.748297619194;3601.243738814826;3604.6034936157002;3619.077135330474;3630.364686179908;3637.381645120336;3640.4539319102346;3645;4200.600942910419;4215.051613387025;4219.07180420307;4229.471316085489;4229.619334259932;4766.165920963817;5007.59635375022;5017.67385119966;5039.622028347889;5073.619478539124;1237.6101528018646;1253.7024179973685;1262.3372729316998;1262.7158889249845;1263.9193489566471;790.3835008693228;802.3380710913519;828.9295409890107;852.8933883264592;857.5026484638895;4495;4529.818807247739;4532.229520981441;4568.588827005586;4579.977100114478;5094.847154585368;5181.689098654093;5191.870203244949;5232.293640358579;5259.6587870093645;4343.587359200871;4459.44256967879;4487.214737420938;4491.797869095899;4604.700694454917;2772.3920126326684;2787.693353731088;2801.6217810595717;2802.1873656639755;2811.718828117213;4956;4957.760559860035;4975.353204083518;4976.402831660152;4978.2034874419915;5087.97456012725;5340.2230839963;5395.946040539623;5403.702796346239;5415.916816636688;4925.901481970341;4955.231939049453;4960.603151747851;4961.8263360781475;4973.449293896045;5243.659162154448;5244.9737751310995;5246.475352464723;5267.552258058108;5283.630145889751;4902.730349830794;5134.306868572844;5159.561437277874;5177.896442071213;5200.60995425337;4939.703617782944;4942.135126352946;4958.603311735124;4963.553280204799;4975.626827987988;3628.4194528875255;3634.6001939786074;3656.8720094796554;3663.432168013962;3666.6699997000396;5190.221466779863;5234.162533994542;5249.291345668286;5257.868553286198;5271.604629652868;5084.288199651977;5085.160948443613;5092.949070509248;5106.642535022661;5109.437961824122;5087.186050232093;5097.770600323069;5101.041395990243;5112.182050871843;5142.6400151989;4805.495422980676;4902.7058376497525;5038.899222015612;5040;5052.191649336089;5010.473900240422;5105.821296254613;5112.130937740519;5120.897582048413;5145.588352931682;4998.500149985118;5008.924866127084;5011;5013.423456302572;5015.322931404214 04:17:35 INFO - PROCESS | 29746 | |5;yui.html;724.6992498113283;724.735471552883;743.108270075909;757.1028331427256;773.5397438524078;12059.39703014849;12755.107142500028;12804.295763732991;13466.394012269448;13793.44826206953;12697.492100316;12736.936315318411;12806;12865.163764355333;12873.3563321834;630.0832289019465;768.5926458976751;785.992140078599;810.2950433123161;817.9672813087469;800.2757504458474;813.4549851599413;815.6085079162006;816.4407380944043;816.677412422093;845.995770021149;849.1041950741965;850.1201256699318;851.3359579527978;852.6248450681711;655.1057806094647;802.743122200896;826.6982551368767;841.1840514700762;841.385788374487;610.2859654204591;610.7343305662007;610.8045425463853;611.150500803883;611.2786911444493;13261.071724979256;13305.467781288833;13320.666983325398;13338.399772010283;13390.397432115578;12756.80864787029;13058.2817945013;13117.934410327982;13375.33123343829;13834;11737.882621173765;11806.822897656457;11844.111691623162;11943.40282985856;12110.39448027604;4216.409702641633;4239.342901850218;4269.487661480611;4270.252705776476;4272.209641216385;60017.39982600205;60111.398886011455;60271;60375.39624603742;61326.69336653333;10271.942582679949;10335.17318614509;10528.052475277262;10566.260361774603;10861.782764344669;18985.43043708691;19012.144453499626;19052.14265358062;19053.7141942871;19069.427917162506;6773.356531129535;6892.689828957709;6937.583744975318;6938.861222775517;7089.0784198053925;3805.961940380616;3807.5621303550447;3808.1622043150464;3880.9223815523533;3895.96104038956;2823.2377258140186;2917.110281364162;2919.4744945909515;2921.97078029217;2923.766098712098;485.2430208874168;502.04110149614064;509.0379183343484;509.06332348478236;510.9718965456861;489.87997940504806;539.692375346049;568.795233715862;588.302746576131;626.7305058824658;8010.759677209693;8717.782055448664;8734.082921293173;8763.649454021896;8906.566994133573;621.1738387944024;635.6408629124622;646;648.7015972652538;649.9935000650028;3829.310724069694;4077.9086834067175;4174.91650167001;4176.9582304177175;4238.87283381499;91262;93064;93183.61347478759;96038;96171.51914240383;79940.60029699931;80532;80794.59602701949;81129.59435202787;82098;70276.64861675659;73333;73752.63123684347;74220;74227.62886185426;7867.881981770163;8080.757577272691;8092.878606820785;8161.755147345589;8346.081930987466;41600;41641.79179104085;41718.58281417147;42932.57067429286;43217.567824322614;45168.77415612901;60008;60339.39660603338;60518.394816053034;61383.38616613777;10104.79790404173;10341.741456463347;10419.42693151884;10668.466576671291;10790.190735694698;10652.62715804943;10725.570977160825;10730.73173170677;11130.109591232844;11231.943840280746;9862.358946668444;10148.644797432054;10154.136898363722;10312.48437578103;10520.789584208425;9838.508074596384;10157.288989770941;10206.081452669;10373.429461379697;10917.83623245636;9897.50512474359;10162.593496260066;10407.115395191493;10479.004494573004;10825.945870270598;8851.247643950337;8886.555672216493;8933.508657023925;8977.506237157018;9029.548522573976;8477.364197685074;8501.87247191305;8607.612657430305;8727.869081963649;8890.822183556422 04:17:35 INFO - PROCESS | 29746 | __end_tp_report 04:17:35 INFO - PROCESS | 29746 | __start_cc_report 04:17:35 INFO - PROCESS | 29746 | _x_x_mozilla_cycle_collect,857 04:17:35 INFO - PROCESS | 29746 | __end_cc_report 04:17:35 INFO - PROCESS | 29746 | __startTimestamp1467199055455__endTimestamp 04:17:35 INFO - PROCESS | 29746 | 04:17:35 INFO - PROCESS | 29746 | ------- Summary: start ------- 04:17:35 INFO - PROCESS | 29746 | Number of tests: 6 04:17:35 INFO - PROCESS | 29746 | 04:17:35 INFO - PROCESS | 29746 | [#0] dojo.html Cycles:165 Average:4628.40 Median:4752.29 stddev:488.48 (10.3%) stddev-sans-first:463.81 04:17:35 INFO - PROCESS | 29746 | Values: 2617.4 2619.5 2655.8 2661.2 2663.1 4530.8 4603.5 4617.7 4683.5 4713.7 4673.6 4673.9 4675.5 4704.6 4710.2 4074.3 4217.6 4312.7 4344.5 4418.1 4328.4 4362.6 4379.4 4383.7 4420.4 4164.8 4194.6 4200.7 4231.9 4248.5 4207.9 4271.2 4286.1 4286.8 4330.6 4252.5 4255.5 4264.0 4311.9 4316.9 4397.9 4631.5 4695.0 4699.4 4721.9 4983.5 4997.1 5000.6 5012.7 5026.5 4879.0 4948.2 5030.2 5052.2 5054.0 4658.5 4725.5 4732.7 4734.4 4736.1 5144.6 5169.2 5173.3 5175.5 5177.6 4791.4 4894.1 4896.2 4912.4 4959.7 4996.5 5032.0 5042.7 5053.0 5100.7 4971.7 4981.6 4987.7 5000.3 5036.9 4819.8 4917.7 4946.2 4988.9 5039.9 4181.1 4181.7 4186.5 4202.5 4225.8 3656.7 3678.1 3681.5 3710.9 3727.6 4279.2 4331.7 4376.9 4401.5 4415.2 5019.1 5060.9 5063.5 5072.2 5102.9 4410.8 4422.5 4433.5 4458.3 4469.4 4330.6 4424.5 4450.6 4460.9 4479.3 4734.5 4752.3 4754.6 4755.6 4808.0 5028.3 5043.1 5043.4 5045.6 5102.3 4604.1 4693.0 4723.7 4743.7 4751.7 4911.7 4933.7 4950.4 4954.1 4993.6 4810.3 4962.7 5024.1 5026.4 5061.9 4804.8 4853.3 4856.3 4874.0 4894.2 4831.0 4867.3 4868.8 4869.1 4912.0 4658.5 4791.1 4807.3 4828.7 4879.5 4924.7 4943.0 4955.0 4971.9 5022.8 4852.1 4861.6 4868.1 4868.9 4916.2 04:17:35 INFO - PROCESS | 29746 | 04:17:35 INFO - PROCESS | 29746 | [#1] ext.html Cycles:180 Average:45592.61 Median:18315.44 stddev:80678.99 (440.5%) stddev-sans-first:80834.45 04:17:35 INFO - PROCESS | 29746 | Values: 554.2 572.7 575.7 593.4 593.8 27650.7 40380.4 41222.2 41357.8 41377.8 42086.8 42515.4 42534.8 42600.0 42610.4 7579.4 7872.1 7989.8 7990.2 10602.4 10421.2 10537.5 10545.5 10548.0 10548.5 10550.6 10593.7 10595.0 10600.3 10607.4 7432.7 10280.6 10479.7 10563.0 10574.0 10377.3 10460.9 10463.7 10466.3 10485.3 39109.0 39513.8 39548.6 39579.2 39618.8 3168.8 3294.4 3419.9 3549.5 3684.5 29790.7 29800.7 29980.6 30095.4 31101.4 3608.0 3643.9 3649.7 3652.5 3748.8 189998.0 190895.0 191108.0 191146.0 191847.0 51901.7 51915.0 52165.5 52196.0 52264.7 33211.0 34293.3 34330.7 36024.6 55766.4 15180.2 15317.2 15356.8 15368.5 15374.7 10498.3 11291.4 11660.7 11702.9 11910.8 18311.4 18460.4 18476.6 18478.4 18479.5 6599.7 6727.9 6782.4 6944.7 7020.2 832.8 884.4 906.2 912.8 996.1 26539.0 28574.6 28780.4 28823.3 28920.7 950.6 978.9 990.1 1017.6 1087.1 15018.8 15042.5 15123.3 15235.4 15247.2 383142.0 388914.0 389631.0 389700.0 392678.0 50403.5 50665.5 51017.5 51105.7 51119.5 1099.3 1184.4 1198.3 1207.2 1233.6 28461.7 29250.9 29577.7 29630.7 30220.2 42500.4 42523.6 43073.8 43114.4 43137.1 305867.0 307038.0 307370.0 308066.0 308563.0 22367.2 24612.3 25607.7 25994.0 26981.6 41854.4 41935.4 41953.8 42689.0 42874.4 35314.1 36124.6 36704.8 36737.3 36779.3 35735.5 36381.0 36404.0 36463.6 36756.4 34805.8 35659.1 36173.3 36286.6 36398.8 30803.7 32471.5 33028.8 33086.0 33147.7 24474.6 25303.7 25315.5 25322.4 25611.2 04:17:35 INFO - PROCESS | 29746 | 04:17:35 INFO - PROCESS | 29746 | [#2] jquery.html Cycles:180 Average:25039.87 Median:211466.26 stddev:67928.93 (32.1%) stddev-sans-first:68094.17 04:17:35 INFO - PROCESS | 29746 | Values: 340.8 346.3 347.8 355.8 362.7 16220.4 17548.8 17813.2 17828.0 17848.6 15747.6 16338.3 16632.3 16632.7 16633.9 4932.4 5110.4 5146.6 5160.0 5162.0 3762.7 3940.1 5059.5 5756.9 6070.8 6063.2 6107.2 6131.0 6142.7 6147.0 5842.4 6029.3 6031.9 6034.9 6039.0 3345.8 4886.2 5194.8 5196.7 5199.2 20567.5 21318.5 21348.1 21486.4 21535.0 1906.4 1980.5 2013.7 2145.3 2448.1 8913.6 9279.7 11841.8 12124.0 13437.4 1697.4 1714.8 1744.5 1764.6 1784.4 69872.0 70117.3 70557.6 71196.3 72627.0 9491.7 9495.9 9512.2 9654.5 9722.6 12772.0 12801.0 12876.6 12879.5 12884.1 7233.1 7237.3 7323.7 7331.0 7525.4 7167.0 7189.3 7308.4 7389.0 7396.0 4089.3 4113.8 4126.9 4132.2 4231.5 1595.2 1603.9 1713.5 1731.3 1743.5 811.0 858.3 876.7 931.2 953.6 16157.6 16900.8 17052.4 17124.6 17437.5 862.0 869.4 881.4 903.2 919.6 9428.3 9856.0 9882.8 9883.3 10010.3 402107.0 405814.0 416020.0 417985.0 418701.0 74025.3 75755.2 75913.0 76153.6 76296.6 905.1 905.1 918.2 932.8 938.6 15290.6 15330.2 15407.0 15578.4 15846.6 36100.1 37375.3 37702.4 38530.0 38593.6 50779.2 51804.7 52084.2 52745.5 53052.5 7230.2 7633.6 7682.3 7734.1 7839.4 11807.3 12034.3 12040.3 12207.5 12256.8 9885.3 9922.1 10021.4 10048.3 10170.3 10512.3 10651.3 10681.3 10700.7 10806.2 10218.0 10321.4 10378.5 10537.4 10586.6 7460.0 7569.5 7579.0 7637.7 7714.7 7977.9 9817.2 9916.5 10044.7 10178.8 04:17:35 INFO - PROCESS | 29746 | 04:17:35 INFO - PROCESS | 29746 | [#3] mootools.html Cycles:180 Average:5006.66 Median:5180.21 stddev:2786.21 (53.8%) stddev-sans-first:2779.46 04:17:35 INFO - PROCESS | 29746 | Values: 1215.0 1356.4 1403.9 1455.7 1660.9 6492.9 7377.4 7633.5 7635.7 7860.4 7553.8 7746.3 7749.2 7752.7 7752.8 2159.8 2193.8 2198.3 2199.4 2199.7 2157.6 2189.0 2192.7 2193.6 2196.2 2151.9 2155.6 2159.0 2167.9 2202.4 2129.4 2134.7 2135.2 2136.0 2136.2 2072.7 2126.9 2129.7 2130.8 2131.8 7534.9 7643.3 7754.4 7774.1 7776.0 4569.6 4687.5 4689.5 4690.8 4693.1 2796.3 2958.7 3002.8 3009.1 3019.9 965.2 969.3 986.3 988.1 992.2 10170.3 10290.8 10306.6 10316.2 10317.2 3982.0 4000.9 4078.1 4085.0 4088.9 8249.2 8290.9 8317.1 8317.1 8322.8 4550.0 4551.3 4552.5 4552.6 4555.7 3613.8 3781.0 4002.6 4063.2 4235.5 3304.4 3309.3 3384.7 3392.0 3393.4 951.0 998.8 1000.8 1003.0 1005.6 705.7 795.4 835.2 836.5 840.4 4940.1 5068.5 5078.0 5162.1 5198.3 826.1 871.6 899.2 901.1 903.5 3384.6 3561.3 3561.7 3569.0 3658.7 9218.5 9348.3 9543.2 9547.2 9559.0 9406.2 9408.4 9413.7 9419.2 9422.9 6926.3 7209.6 7209.7 7212.9 7366.9 5121.6 5122.2 5122.3 5141.4 5267.1 8480.6 8644.3 8648.0 8688.4 8746.7 8564.6 8710.0 8753.4 8792.0 8928.1 5989.2 6035.4 6120.3 6179.5 6289.8 7309.7 7617.7 7625.1 7625.2 7638.4 6631.8 6861.3 6866.2 6888.4 6912.2 6454.3 6537.2 6751.5 6780.2 6927.7 5946.5 6024.4 6044.1 6055.3 6055.9 4385.6 4424.0 4609.9 4622.7 4642.5 4394.3 4460.1 4473.0 4487.9 4529.9 04:17:35 INFO - PROCESS | 29746 | 04:17:35 INFO - PROCESS | 29746 | [#4] prototype.html Cycles:180 Average:4206.56 Median:4877.44 stddev:1240.32 (25.4%) stddev-sans-first:1208.39 04:17:35 INFO - PROCESS | 29746 | Values: 285.7 286.0 287.5 292.0 292.1 4878.4 4897.0 4902.3 4902.9 4972.2 4748.2 4752.0 4811.1 4876.5 4889.6 3533.7 3643.3 3678.4 3735.9 3777.1 3718.5 3741.6 3744.8 3765.7 3767.9 3538.6 3704.3 3710.3 3720.6 3738.8 3622.9 3747.5 3750.4 3752.9 3757.3 3299.0 3311.4 3312.0 3322.1 3327.0 4685.8 4728.7 4729.0 4750.7 4758.5 4186.2 4280.7 4310.2 4330.3 4330.5 5036.5 5056.6 5092.3 5102.9 5110.5 3640.0 3643.5 3647.3 3658.8 3661.0 5013.5 5303.5 5323.0 5324.7 5361.8 3562.9 3584.2 3595.7 3601.2 3604.6 3619.1 3630.4 3637.4 3640.5 3645.0 4200.6 4215.1 4219.1 4229.5 4229.6 4766.2 5007.6 5017.7 5039.6 5073.6 1237.6 1253.7 1262.3 1262.7 1263.9 790.4 802.3 828.9 852.9 857.5 4495.0 4529.8 4532.2 4568.6 4580.0 5094.8 5181.7 5191.9 5232.3 5259.7 4343.6 4459.4 4487.2 4491.8 4604.7 2772.4 2787.7 2801.6 2802.2 2811.7 4956.0 4957.8 4975.4 4976.4 4978.2 5088.0 5340.2 5395.9 5403.7 5415.9 4925.9 4955.2 4960.6 4961.8 4973.4 5243.7 5245.0 5246.5 5267.6 5283.6 4902.7 5134.3 5159.6 5177.9 5200.6 4939.7 4942.1 4958.6 4963.6 4975.6 3628.4 3634.6 3656.9 3663.4 3666.7 5190.2 5234.2 5249.3 5257.9 5271.6 5084.3 5085.2 5092.9 5106.6 5109.4 5087.2 5097.8 5101.0 5112.2 5142.6 4805.5 4902.7 5038.9 5040.0 5052.2 5010.5 5105.8 5112.1 5120.9 5145.6 4998.5 5008.9 5011.0 5013.4 5015.3 04:17:35 INFO - PROCESS | 29746 | 04:17:35 INFO - PROCESS | 29746 | [#5] yui.html Cycles:180 Average:17130.98 Median:578.55 stddev:24329.73 (4205.3%) stddev-sans-first:24366.79 04:17:35 INFO - PROCESS | 29746 | Values: 724.7 724.7 743.1 757.1 773.5 12059.4 12755.1 12804.3 13466.4 13793.4 12697.5 12736.9 12806.0 12865.2 12873.4 630.1 768.6 786.0 810.3 818.0 800.3 813.5 815.6 816.4 816.7 846.0 849.1 850.1 851.3 852.6 655.1 802.7 826.7 841.2 841.4 610.3 610.7 610.8 611.2 611.3 13261.1 13305.5 13320.7 13338.4 13390.4 12756.8 13058.3 13117.9 13375.3 13834.0 11737.9 11806.8 11844.1 11943.4 12110.4 4216.4 4239.3 4269.5 4270.3 4272.2 60017.4 60111.4 60271.0 60375.4 61326.7 10271.9 10335.2 10528.1 10566.3 10861.8 18985.4 19012.1 19052.1 19053.7 19069.4 6773.4 6892.7 6937.6 6938.9 7089.1 3806.0 3807.6 3808.2 3880.9 3896.0 2823.2 2917.1 2919.5 2922.0 2923.8 485.2 502.0 509.0 509.1 511.0 489.9 539.7 568.8 588.3 626.7 8010.8 8717.8 8734.1 8763.6 8906.6 621.2 635.6 646.0 648.7 650.0 3829.3 4077.9 4174.9 4177.0 4238.9 91262.0 93064.0 93183.6 96038.0 96171.5 79940.6 80532.0 80794.6 81129.6 82098.0 70276.6 73333.0 73752.6 74220.0 74227.6 7867.9 8080.8 8092.9 8161.8 8346.1 41600.0 41641.8 41718.6 42932.6 43217.6 45168.8 60008.0 60339.4 60518.4 61383.4 10104.8 10341.7 10419.4 10668.5 10790.2 10652.6 10725.6 10730.7 11130.1 11231.9 9862.4 10148.6 10154.1 10312.5 10520.8 9838.5 10157.3 10206.1 10373.4 10917.8 9897.5 10162.6 10407.1 10479.0 10825.9 8851.2 8886.6 8933.5 8977.5 9029.5 8477.4 8501.9 8607.6 8727.9 8890.8 04:17:35 INFO - PROCESS | 29746 | -------- Summary: end -------- 04:17:35 INFO - PROCESS | 29746 | 04:17:36 INFO - TEST-INFO | 29746: exit 0 04:17:36 INFO - TEST-OK | dromaeo_css | took 1119330ms 04:17:36 INFO - TEST-START | kraken 04:17:36 INFO - operating with platform_type : linux_ 04:17:36 INFO - Initialising browser for kraken test... 04:17:36 INFO - TEST-INFO | started process 29928 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9DL1Ib/profile http://localhost:56229/getInfo.html) 04:17:40 INFO - PROCESS | 29928 | __metrics Screen width/height:1600/1200 04:17:40 INFO - PROCESS | 29928 | colorDepth:24 04:17:40 INFO - PROCESS | 29928 | Browser inner width/height: 1024/697 04:17:40 INFO - PROCESS | 29928 | __metrics 04:17:41 INFO - PROCESS | 29928 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:17:42 INFO - TEST-INFO | 29928: exit 0 04:17:42 INFO - Browser initialized. 04:17:42 INFO - Running cycle 1/1 for kraken test... 04:17:42 INFO - TEST-INFO | started process 30010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9DL1Ib/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:17:54 INFO - PROCESS | 30010 | RSS: Main: 158560256 04:17:54 INFO - PROCESS | 30010 | 04:17:57 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:56229/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56229/tests/kraken/driver.html?testName=audio-beat-detection) 04:17:58 INFO - PROCESS | 30010 | RSS: Main: 216264704 04:17:58 INFO - PROCESS | 30010 | 04:18:01 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:56229/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56229/tests/kraken/driver.html?testName=audio-dft) 04:18:01 INFO - PROCESS | 30010 | RSS: Main: 204578816 04:18:01 INFO - PROCESS | 30010 | 04:18:04 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:56229/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56229/tests/kraken/driver.html?testName=audio-fft) 04:18:05 INFO - PROCESS | 30010 | RSS: Main: 269987840 04:18:05 INFO - PROCESS | 30010 | 04:18:07 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:56229/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56229/tests/kraken/driver.html?testName=audio-oscillator) 04:18:08 INFO - PROCESS | 30010 | RSS: Main: 180842496 04:18:08 INFO - PROCESS | 30010 | 04:18:10 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:56229/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56229/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:18:11 INFO - PROCESS | 30010 | RSS: Main: 185204736 04:18:11 INFO - PROCESS | 30010 | 04:18:14 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:56229/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56229/tests/kraken/driver.html?testName=imaging-darkroom) 04:18:14 INFO - PROCESS | 30010 | RSS: Main: 220921856 04:18:14 INFO - PROCESS | 30010 | 04:18:18 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:56229/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56229/tests/kraken/driver.html?testName=imaging-desaturate) 04:18:19 INFO - PROCESS | 30010 | RSS: Main: 217112576 04:18:19 INFO - PROCESS | 30010 | 04:18:21 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:56229/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56229/tests/kraken/driver.html?testName=json-parse-financial) 04:18:22 INFO - PROCESS | 30010 | RSS: Main: 219955200 04:18:22 INFO - PROCESS | 30010 | 04:18:24 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:56229/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56229/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:18:24 INFO - PROCESS | 30010 | RSS: Main: 206708736 04:18:24 INFO - PROCESS | 30010 | 04:18:26 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:56229/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56229/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:18:27 INFO - PROCESS | 30010 | RSS: Main: 211611648 04:18:27 INFO - PROCESS | 30010 | 04:18:29 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:56229/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56229/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:18:30 INFO - PROCESS | 30010 | RSS: Main: 219369472 04:18:30 INFO - PROCESS | 30010 | 04:18:33 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:56229/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:18:33 INFO - PROCESS | 30010 | RSS: Main: 222957568 04:18:33 INFO - PROCESS | 30010 | 04:18:36 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:56229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:18:37 INFO - PROCESS | 30010 | RSS: Main: 222433280 04:18:37 INFO - PROCESS | 30010 | 04:18:38 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:56229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56229/tests/kraken/driver.html?testName=ai-astar) 04:18:39 INFO - PROCESS | 30010 | RSS: Main: 265555968 04:18:39 INFO - PROCESS | 30010 | 04:18:39 INFO - PROCESS | 30010 | __start_tp_report 04:18:39 INFO - PROCESS | 30010 | _x_x_mozilla_page_load 04:18:39 INFO - PROCESS | 30010 | _x_x_mozilla_page_load_details 04:18:39 INFO - PROCESS | 30010 | |i|pagename|runs| 04:18:39 INFO - PROCESS | 30010 | |0;ai-astar;102;113;114;113;111;112;112;115;113;115 04:18:39 INFO - PROCESS | 30010 | |1;audio-beat-detection;159;138;140;183;130;156;155;137;189;130 04:18:39 INFO - PROCESS | 30010 | |2;audio-dft;161;163;160;162;161;162;163;161;161;161 04:18:39 INFO - PROCESS | 30010 | |3;audio-fft;76;75;76;120;77;76;75;78;100;77 04:18:39 INFO - PROCESS | 30010 | |4;audio-oscillator;87;86;120;87;87;86;120;86;86;120 04:18:39 INFO - PROCESS | 30010 | |5;imaging-gaussian-blur;117;117;117;117;117;118;119;117;117;117 04:18:39 INFO - PROCESS | 30010 | |6;imaging-darkroom;147;147;147;147;147;146;148;147;146;147 04:18:39 INFO - PROCESS | 30010 | |7;imaging-desaturate;95;95;96;95;95;95;96;95;95;95 04:18:39 INFO - PROCESS | 30010 | |8;json-parse-financial;64;64;64;64;65;65;65;64;65;64 04:18:39 INFO - PROCESS | 30010 | |9;json-stringify-tinderbox;64;63;64;64;65;64;64;66;63;63 04:18:39 INFO - PROCESS | 30010 | |10;stanford-crypto-aes;83;82;85;89;86;91;90;90;93;88 04:18:39 INFO - PROCESS | 30010 | |11;stanford-crypto-ccm;132;135;130;137;133;132;127;133;149;132 04:18:39 INFO - PROCESS | 30010 | |12;stanford-crypto-pbkdf2;167;166;170;164;172;164;169;171;172;171 04:18:39 INFO - PROCESS | 30010 | |13;stanford-crypto-sha256-iterative;66;67;65;67;65;66;67;66;68;65 04:18:39 INFO - PROCESS | 30010 | __end_tp_report 04:18:39 INFO - PROCESS | 30010 | __start_cc_report 04:18:39 INFO - PROCESS | 30010 | _x_x_mozilla_cycle_collect,1859 04:18:39 INFO - PROCESS | 30010 | __end_cc_report 04:18:39 INFO - PROCESS | 30010 | __startTimestamp1467199119101__endTimestamp 04:18:39 INFO - PROCESS | 30010 | 04:18:39 INFO - PROCESS | 30010 | ------- Summary: start ------- 04:18:39 INFO - PROCESS | 30010 | Number of tests: 14 04:18:39 INFO - PROCESS | 30010 | 04:18:39 INFO - PROCESS | 30010 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.74 (3.3%) stddev-sans-first:1.36 04:18:39 INFO - PROCESS | 30010 | Values: 102.0 113.0 114.0 113.0 111.0 112.0 112.0 115.0 113.0 115.0 04:18:39 INFO - PROCESS | 30010 | 04:18:39 INFO - PROCESS | 30010 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:155.50 stddev:20.91 (13.4%) stddev-sans-first:22.01 04:18:39 INFO - PROCESS | 30010 | Values: 159.0 138.0 140.0 183.0 130.0 156.0 155.0 137.0 189.0 130.0 04:18:39 INFO - PROCESS | 30010 | 04:18:39 INFO - PROCESS | 30010 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 04:18:39 INFO - PROCESS | 30010 | Values: 161.0 163.0 160.0 162.0 161.0 162.0 163.0 161.0 161.0 161.0 04:18:39 INFO - PROCESS | 30010 | 04:18:39 INFO - PROCESS | 30010 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:15.02 (19.8%) stddev-sans-first:15.71 04:18:39 INFO - PROCESS | 30010 | Values: 76.0 75.0 76.0 120.0 77.0 76.0 75.0 78.0 100.0 77.0 04:18:39 INFO - PROCESS | 30010 | 04:18:39 INFO - PROCESS | 30010 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:86.00 stddev:16.22 (18.9%) stddev-sans-first:16.84 04:18:39 INFO - PROCESS | 30010 | Values: 87.0 86.0 120.0 87.0 87.0 86.0 120.0 86.0 86.0 120.0 04:18:39 INFO - PROCESS | 30010 | 04:18:39 INFO - PROCESS | 30010 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 04:18:39 INFO - PROCESS | 30010 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 119.0 117.0 117.0 117.0 04:18:39 INFO - PROCESS | 30010 | 04:18:39 INFO - PROCESS | 30010 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 04:18:39 INFO - PROCESS | 30010 | Values: 147.0 147.0 147.0 147.0 147.0 146.0 148.0 147.0 146.0 147.0 04:18:39 INFO - PROCESS | 30010 | 04:18:39 INFO - PROCESS | 30010 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:18:39 INFO - PROCESS | 30010 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 04:18:39 INFO - PROCESS | 30010 | 04:18:39 INFO - PROCESS | 30010 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 04:18:39 INFO - PROCESS | 30010 | Values: 64.0 64.0 64.0 64.0 65.0 65.0 65.0 64.0 65.0 64.0 04:18:39 INFO - PROCESS | 30010 | 04:18:39 INFO - PROCESS | 30010 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.94 (1.5%) stddev-sans-first:1.00 04:18:39 INFO - PROCESS | 30010 | Values: 64.0 63.0 64.0 64.0 65.0 64.0 64.0 66.0 63.0 63.0 04:18:39 INFO - PROCESS | 30010 | 04:18:39 INFO - PROCESS | 30010 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:89.50 stddev:3.59 (4.0%) stddev-sans-first:3.38 04:18:39 INFO - PROCESS | 30010 | Values: 83.0 82.0 85.0 89.0 86.0 91.0 90.0 90.0 93.0 88.0 04:18:39 INFO - PROCESS | 30010 | 04:18:39 INFO - PROCESS | 30010 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:133.00 stddev:5.91 (4.4%) stddev-sans-first:6.22 04:18:39 INFO - PROCESS | 30010 | Values: 132.0 135.0 130.0 137.0 133.0 132.0 127.0 133.0 149.0 132.0 04:18:39 INFO - PROCESS | 30010 | 04:18:39 INFO - PROCESS | 30010 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:170.50 stddev:3.13 (1.8%) stddev-sans-first:3.27 04:18:39 INFO - PROCESS | 30010 | Values: 167.0 166.0 170.0 164.0 172.0 164.0 169.0 171.0 172.0 171.0 04:18:39 INFO - PROCESS | 30010 | 04:18:39 INFO - PROCESS | 30010 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.03 (1.6%) stddev-sans-first:1.09 04:18:39 INFO - PROCESS | 30010 | Values: 66.0 67.0 65.0 67.0 65.0 66.0 67.0 66.0 68.0 65.0 04:18:39 INFO - PROCESS | 30010 | -------- Summary: end -------- 04:18:39 INFO - PROCESS | 30010 | 04:18:40 INFO - TEST-INFO | 30010: exit 0 04:18:40 INFO - TEST-OK | kraken | took 63922ms 04:18:40 INFO - SUITE-END | took 1183s 04:18:40 INFO - Completed test suite (00:19:43) 04:18:40 INFO - javascript benchmark 04:18:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2617.3849145450818, 2619.5415802234606, 2655.7609815116643, 2661.188337557044, 2663.081236973245, 4530.818767249314, 4603.539646035395, 4617.722936623801, 4683.531646835319, 4713.693609915357, 4673.602743766775, 4673.929891051637, 4675.50907154749, 4704.600108990731, 4710.246360582308, 4074.30736774749, 4217.641500472456, 4312.654987600984, 4344.4786625604975, 4418.050119224366, 4328.415663885383, 4362.607365337119, 4379.364992076147, 4383.715058521186, 4420.403245561856, 4164.833406663745, 4194.559571245037, 4200.684948628865, 4231.87304380869, 4248.511421186572, 4207.91584168318, 4271.231178387889, 4286.142771445723, 4286.76422796746, 4330.588594083557, 4252.489701235841, 4255.468066491689, 4263.978680106579, 4311.892202694927, 4316.935245971313, 4397.868063958054, 4631.536846315342, 4695.037517308943, 4699.389079419653, 4721.929171062402, 4983.526564976321, 4997.0505603935135, 5000.574951129122, 5012.72430016349, 5026.497350264981, 4878.951210487885, 4948.158813001798, 5030.195168773015, 5052.166392545226, 5054.039732450859, 4658.4642766082, 4725.4565724941385, 4732.716037037789, 4734.4081989751285, 4736.123817093849, 5144.562712169432, 5169.198774190007, 5173.301604283449, 5175.534201921845, 5177.58579313654, 4791.425028996473, 4894.11905856942, 4896.2410826321975, 4912.4350699669285, 4959.677620954699, 4996.500349964975, 5031.974840125776, 5042.672226305352, 5053.0, 5100.719460429712, 4971.651984361132, 4981.576565991859, 4987.725675087905, 5000.3249561309485, 5036.949630503721, 4819.807207711722, 4917.680350777259, 4946.159152944008, 4988.90022199554, 5039.874003149877, 4181.080162364275, 4181.728187667853, 4186.539480657125, 4202.474690663667, 4225.767582782915, 3656.670899619047, 3678.0988657779017, 3681.4661874028116, 3710.851565937386, 3727.552693676776, 4279.229738647011, 4331.696781225284, 4376.912461750747, 4401.493828209733, 4415.249407600716, 5019.071471777733, 5060.898782024339, 5063.518965698253, 5072.213806859942, 5102.923456148161, 4410.779461027, 4422.513523512411, 4433.46798384196, 4458.308962110878, 4469.396631454777, 4330.631896288788, 4424.535423780521, 4450.599446049871, 4460.910781784346, 4479.283314669638, 4734.479207287264, 4752.287156926489, 4754.619630429626, 4755.5719985201495, 4808.0383923216195, 5028.34631497903, 5043.117454445384, 5043.36957880265, 5045.621578381562, 5102.260172274925, 4604.148232576984, 4693.0, 4723.740194289209, 4743.739094349706, 4751.714897106184, 4911.656184067081, 4933.728644924564, 4950.430700469492, 4954.083494553519, 4993.6254780892305, 4810.278458231293, 4962.6774259673, 5024.0956627807345, 5026.44709082008, 5061.9493805061475, 4804.831830886042, 4853.344798452164, 4856.320115183807, 4874.0495603357, 4894.241392584155, 4830.975845120752, 4867.318575399376, 4868.756562171948, 4869.074875773592, 4912.0, 4658.534146585314, 4791.089692958327, 4807.326974223542, 4828.66199366055, 4879.536444037811, 4924.679895806761, 4942.975285123552, 4955.0, 4971.900561988812, 5022.799088036438, 4852.078105160008, 4861.586765125004, 4868.148074087091, 4868.853934381974, 4916.164252077084], "value": 4597.347879292939, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.1757793676095, 572.6850232372195, 575.7351618255603, 593.3858456497524, 593.8159170657094, 27650.723492765068, 40380.394294085614, 41222.17555648885, 41357.759267222034, 41377.79311103448, 42086.789566052124, 42515.36226956598, 42534.78732606333, 42600.0, 42610.36084458728, 7579.355754760852, 7872.134065252818, 7989.800254993643, 7990.240927111944, 10602.416867072308, 10421.166306695446, 10537.47312634369, 10545.472726363689, 10548.0, 10548.525316360743, 10550.577976880953, 10593.73515662107, 10595.046445819875, 10600.310979786327, 10607.416592087433, 7432.739854105107, 10280.640177593823, 10479.685609431692, 10562.996515331108, 10574.0, 10377.325473844252, 10460.895391046068, 10463.68608941733, 10466.319689220252, 10485.266031377807, 39109.0, 39513.81458556248, 39548.60451395507, 39579.20841583152, 39618.80190599057, 3168.7940283881703, 3294.4234758917096, 3419.880304189366, 3549.4675798630155, 3684.5394325709285, 29790.70209297901, 29800.701992980008, 29980.55029174564, 30095.398092038256, 31101.377972440423, 3607.981960090209, 3643.8542458301636, 3649.6897763690117, 3652.543432070991, 3748.812559372048, 189998.0, 190895.0, 191108.0, 191145.9999999986, 191847.0, 51901.7404912973, 51915.0, 52165.47834521682, 52195.95608087893, 52264.73867630713, 33211.0, 34293.314133717184, 34330.73857983488, 36024.639753602125, 55766.44233557694, 15180.240987950558, 15317.157556334509, 15356.769648455282, 15368.462103826312, 15374.692506150039, 10498.317609355367, 11291.3789741565, 11660.708482288012, 11702.88297117035, 11910.761784764256, 18311.359102431616, 18460.446186614423, 18476.630467390576, 18478.353257635918, 18479.53801154955, 6599.73601055962, 6727.865442691119, 6782.389584937379, 6944.652767361612, 7020.192677842114, 832.8292699996487, 884.3676771108688, 906.1663269791808, 912.8356895758827, 996.0885789502524, 26539.0, 28574.571381429294, 28780.42439151247, 28823.2794180143, 28920.710792892223, 950.5579905344048, 978.8825340958988, 990.0643891522586, 1017.6164253855959, 1087.141158484788, 15018.849811501745, 15042.473513426978, 15123.31945062475, 15235.3905843765, 15247.23763811805, 383142.0, 388914.0, 389631.0, 389700.0, 392678.0, 50403.49596503988, 50665.49334506682, 51017.48982510201, 51105.74447127741, 51119.48880511222, 1099.2689861242345, 1184.4281075050299, 1198.3229475346575, 1207.185150023748, 1233.5805826019196, 28461.715382846734, 29250.853745731136, 29577.704222958357, 29630.703692962794, 30220.24449388783, 42500.36249456199, 42523.574764251964, 43073.7846310779, 43114.353284701385, 43137.13725725531, 305867.0, 307038.0, 307370.0, 308066.0, 308563.0, 22367.217147399762, 24612.261632151065, 25607.743922560538, 25994.0, 26981.595276070482, 41854.37218441665, 41935.37096943487, 41953.790231048646, 42689.0, 42874.35688464738, 35314.11714707153, 36124.638753612126, 36704.81647591852, 36737.26525469422, 36779.26441471209, 35735.46396804102, 36381.0, 36404.0, 36463.635363646026, 36756.44865327076, 34805.825970869984, 35659.10852228715, 36173.27653446969, 36286.63713362833, 36398.8180059098, 30803.69196308098, 32471.512927305637, 33028.83485582557, 33086.0, 33147.66852331446, 24474.632880507164, 25303.74696253014, 25315.493690126463, 25322.366940826625, 25611.231663050137], "value": 18042.947015822338, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.754656647214, 346.3367650948434, 347.8017530007895, 355.8238671857431, 362.6572888620253, 16220.432284870032, 17548.82451175488, 17813.198406071726, 17828.0, 17848.553786155335, 15747.60630984226, 16338.34646614134, 16632.33470661172, 16632.66734665306, 16633.916830415863, 4932.432770231433, 5110.412302585213, 5146.639735218536, 5160.045391602547, 5162.045021671003, 3762.6613604775566, 3940.113474468236, 5059.468755780646, 5756.913646295309, 6070.757169713228, 6063.242094738158, 6107.206063211798, 6131.049687298476, 6142.662153581551, 6146.969265153691, 5842.444967728059, 6029.306629737593, 6031.939680603182, 6034.939650603482, 6039.033754599265, 3345.8159801210923, 4886.218205087169, 5194.766235519411, 5196.68819870809, 5199.220116982445, 20567.485812854797, 21318.46703832401, 21348.146074157172, 21486.35540933759, 21535.0, 1906.4090132059107, 1980.4751740788702, 2013.6979453082008, 2145.2598853395552, 2448.069733501276, 8913.643454261823, 9279.675211367638, 11841.822372664417, 12124.0, 13437.395317210749, 1697.4398448512086, 1714.7856517935259, 1744.5376975101608, 1764.6117854072083, 1784.4200634793744, 69872.0, 70117.29882701108, 70557.64721176412, 71196.28803711948, 72627.0, 9491.715248542554, 9495.90504094964, 9512.191463725523, 9654.469004204695, 9722.61109555624, 12772.0, 12801.01584254442, 12876.613701588967, 12879.549215777402, 12884.098113131991, 7233.095863017123, 7237.312455316736, 7323.670434830446, 7330.96334518324, 7525.397968162534, 7166.964165179141, 7189.281071892873, 7308.37878780299, 7389.0, 7396.038514993016, 4089.3048181809163, 4113.835446582103, 4126.91746165081, 4132.152908653718, 4231.513375961742, 1595.2422599265255, 1603.9475651697014, 1713.4773893962213, 1731.342090005815, 1743.450812993903, 810.9837803243902, 858.3305022082785, 876.6668665906915, 931.2038207332633, 953.5994882149514, 16157.59606009859, 16900.83099169017, 17052.403165889133, 17124.633218529194, 17437.51781098621, 861.9784505387415, 869.3566760597113, 881.4314766975265, 903.1510380242551, 919.558611866308, 9428.340016198801, 9856.008316631633, 9882.752931176778, 9883.258755593359, 10010.299279050541, 402107.0, 405814.0, 416020.0, 417985.0, 418701.0, 74025.25974740292, 75755.24244757592, 75913.0, 76153.61923190349, 76296.61851690817, 905.0994260710635, 905.1401168889581, 918.2149262380702, 932.7621456528677, 938.591712605019, 15290.617734556725, 15330.233488325763, 15407.0, 15578.376864925276, 15846.60383490422, 36100.09749756277, 37375.252494950495, 37702.43446348252, 38530.0, 38593.614063859, 50779.238311426096, 51804.740976294874, 52084.21873671822, 52745.47254527405, 53052.469475306294, 7230.240824713329, 7633.580153091633, 7682.270184332479, 7734.149243583089, 7839.432113577422, 11807.291562506278, 12034.277943323428, 12040.337781422106, 12207.511699531919, 12256.816147757612, 9885.258605604753, 9922.107010369102, 10021.448820314952, 10048.296619236584, 10170.288079834341, 10512.26414151002, 10651.30766500175, 10681.252312338373, 10700.678979630624, 10806.18953578469, 10218.0, 10321.380717156995, 10378.481075946323, 10537.42044187577, 10586.576536938435, 7460.0, 7569.5079819811535, 7579.0, 7637.732679356196, 7714.6914123434435, 7977.880331795144, 9817.165540929102, 9916.504174791087, 10044.748881277734, 10178.847317290394], "value": 8264.801145119722, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1215.0401183065378, 1356.4099616666747, 1403.936822842972, 1455.7234125516152, 1660.9169541522922, 6492.870142597145, 7377.4466914981385, 7633.46565740397, 7635.656395462203, 7860.371170306362, 7553.773386798391, 7746.264104910038, 7749.225077492248, 7752.651130699118, 7752.7674169775, 2159.762426133128, 2193.8135258502966, 2198.2525941179997, 2199.3621849663577, 2199.736031676201, 2157.590057889004, 2188.9562208755815, 2192.6710993350966, 2193.594185075758, 2196.176433837311, 2151.8924053797327, 2155.5796619659172, 2158.956820863582, 2167.945801354963, 2202.4383782135615, 2129.361191642509, 2134.7438307403054, 2135.1566131378017, 2135.9786402136015, 2136.177571634916, 2072.678734796109, 2126.8723876567456, 2129.7337832770904, 2130.7975742304457, 2131.7761635028255, 7534.886976695299, 7643.273888980538, 7754.418418618626, 7774.144844067148, 7775.961120194419, 4569.611583015448, 4687.460941991646, 4689.484156742756, 4690.788914498856, 4693.084848454553, 2796.3288810685494, 2958.7189217024347, 3002.804817686865, 3009.0521485732143, 3019.9245018874485, 965.2374624046995, 969.2972594868734, 986.2997271936933, 988.0712130597287, 992.1913640383137, 10170.338927969658, 10290.845637315446, 10306.639267625673, 10316.1747060235, 10317.226208034352, 3981.9845939285296, 4000.9399859002137, 4078.0824314528995, 4084.9583356243966, 4088.9182216355507, 8249.216324449288, 8290.917090829134, 8317.085120636724, 8317.126701696356, 8322.833543329221, 4549.954500455019, 4551.271796512542, 4552.453705555355, 4552.635789136861, 4555.681102322872, 3613.837377318027, 3781.035835861893, 4002.5597184309704, 4063.227986682521, 4235.4917409910395, 3304.3721692878275, 3309.2885029718727, 3384.6784555467193, 3391.983040084833, 3393.3891899458336, 950.9619615215453, 998.7602975285879, 1000.7648202672366, 1003.0420947994647, 1005.6480231918916, 705.7212401101639, 795.363709032783, 835.2232423845882, 836.506461187902, 840.369722707969, 4940.086084074458, 5068.518490743373, 5078.035173317058, 5162.148245539519, 5198.2722418861385, 826.1201820061615, 871.5729292646557, 899.150302963706, 901.1439132823843, 903.5256490342623, 3384.593848738118, 3561.269939662363, 3561.661642144044, 3568.9643103568633, 3658.689011434005, 9218.53907304632, 9348.345615806827, 9543.236541076698, 9547.188488978514, 9559.0, 9406.200472959737, 9408.43549387039, 9413.670521531714, 9419.152276295166, 9422.90577094234, 6926.272741362185, 7209.639518024078, 7209.71161153548, 7212.927870721331, 7366.889496657554, 5121.641485096007, 5122.206058061007, 5122.282880396673, 5141.434442211279, 5267.104592219255, 8480.575971201539, 8644.308455323684, 8647.956760216159, 8688.435251708619, 8746.65013399457, 8564.614592343234, 8709.956450217709, 8753.387262891536, 8791.956040219759, 8928.10718928128, 5989.161517387656, 6035.36628653985, 6120.296165940796, 6179.536534759821, 6289.842753931189, 7309.744158954411, 7617.69529218825, 7625.123110842324, 7625.23747625233, 7638.388928885564, 6631.834204144742, 6861.2795656455355, 6866.244713081457, 6888.448924085961, 6912.170539535288, 6454.322296158835, 6537.182852143482, 6751.527393082633, 6780.186377634715, 6927.6882540286815, 5946.494547963472, 6024.367441418588, 6044.063170208625, 6055.333913269625, 6055.939440605714, 4385.561443855589, 4424.048829501673, 4609.907801843878, 4622.745748983838, 4642.466116396523, 4394.252976993983, 4460.085682435158, 4473.0, 4487.910241795211, 4529.886752831206], "value": 4039.2613797420895, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.708616892522, 285.9771218302536, 287.4524031719574, 291.96642386125603, 292.1454744871251, 4878.365812444382, 4896.9961157962625, 4902.259697807276, 4902.8774280643, 4972.2293044578055, 4748.240281554952, 4752.0, 4811.13399588074, 4876.512348765122, 4889.608831293497, 3533.734969877263, 3643.25313310772, 3678.429843374281, 3735.8879233623034, 3777.112378591029, 3718.4794128821986, 3741.5884252732176, 3744.794036328001, 3765.698744100479, 3767.9058023549355, 3538.575370955489, 3704.2776658551593, 3710.2764960832646, 3720.6465385788306, 3738.756980796253, 3622.9094272643133, 3747.4940882980723, 3750.4186851038135, 3752.924941501168, 3757.3236817372863, 3299.0, 3311.420501412243, 3311.966880331214, 3322.1196382958537, 3326.9833650831833, 4685.7657117144345, 4728.739919304437, 4728.952710472886, 4750.667453278272, 4758.476567577563, 4186.225548273579, 4280.657547396201, 4310.202612516695, 4330.2638551446325, 4330.523642399365, 5036.546710796046, 5056.62075344347, 5092.28707980883, 5102.923456148161, 5110.540051395392, 3639.981800091009, 3643.544556930384, 3647.3434781739275, 3658.756022952209, 3660.9816950915074, 5013.548780609763, 5303.469653034705, 5323.0, 5324.653897496651, 5361.839144825701, 3562.946555801665, 3584.2473080653353, 3595.748297619194, 3601.243738814826, 3604.6034936157002, 3619.077135330474, 3630.364686179908, 3637.381645120336, 3640.4539319102346, 3645.0, 4200.600942910419, 4215.051613387025, 4219.07180420307, 4229.471316085489, 4229.619334259932, 4766.165920963817, 5007.59635375022, 5017.67385119966, 5039.622028347889, 5073.619478539124, 1237.6101528018646, 1253.7024179973685, 1262.3372729316998, 1262.7158889249845, 1263.9193489566471, 790.3835008693228, 802.3380710913519, 828.9295409890107, 852.8933883264592, 857.5026484638895, 4495.0, 4529.818807247739, 4532.229520981441, 4568.588827005586, 4579.977100114478, 5094.847154585368, 5181.689098654093, 5191.870203244949, 5232.293640358579, 5259.6587870093645, 4343.587359200871, 4459.44256967879, 4487.214737420938, 4491.797869095899, 4604.700694454917, 2772.3920126326684, 2787.693353731088, 2801.6217810595717, 2802.1873656639755, 2811.718828117213, 4956.0, 4957.760559860035, 4975.353204083518, 4976.402831660152, 4978.2034874419915, 5087.97456012725, 5340.2230839963, 5395.946040539623, 5403.702796346239, 5415.916816636688, 4925.901481970341, 4955.231939049453, 4960.603151747851, 4961.8263360781475, 4973.449293896045, 5243.659162154448, 5244.9737751310995, 5246.475352464723, 5267.552258058108, 5283.630145889751, 4902.730349830794, 5134.306868572844, 5159.561437277874, 5177.896442071213, 5200.60995425337, 4939.703617782944, 4942.135126352946, 4958.603311735124, 4963.553280204799, 4975.626827987988, 3628.4194528875255, 3634.6001939786074, 3656.8720094796554, 3663.432168013962, 3666.6699997000396, 5190.221466779863, 5234.162533994542, 5249.291345668286, 5257.868553286198, 5271.604629652868, 5084.288199651977, 5085.160948443613, 5092.949070509248, 5106.642535022661, 5109.437961824122, 5087.186050232093, 5097.770600323069, 5101.041395990243, 5112.182050871843, 5142.6400151989, 4805.495422980676, 4902.7058376497525, 5038.899222015612, 5040.0, 5052.191649336089, 5010.473900240422, 5105.821296254613, 5112.130937740519, 5120.897582048413, 5145.588352931682, 4998.500149985118, 5008.924866127084, 5011.0, 5013.423456302572, 5015.322931404214], "value": 3805.892777235176, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.6992498113283, 724.735471552883, 743.108270075909, 757.1028331427256, 773.5397438524078, 12059.39703014849, 12755.107142500028, 12804.295763732991, 13466.394012269448, 13793.44826206953, 12697.492100316, 12736.936315318411, 12806.0, 12865.163764355333, 12873.3563321834, 630.0832289019465, 768.5926458976751, 785.992140078599, 810.2950433123161, 817.9672813087469, 800.2757504458474, 813.4549851599413, 815.6085079162006, 816.4407380944043, 816.677412422093, 845.995770021149, 849.1041950741965, 850.1201256699318, 851.3359579527978, 852.6248450681711, 655.1057806094647, 802.743122200896, 826.6982551368767, 841.1840514700762, 841.385788374487, 610.2859654204591, 610.7343305662007, 610.8045425463853, 611.150500803883, 611.2786911444493, 13261.071724979256, 13305.467781288833, 13320.666983325398, 13338.399772010283, 13390.397432115578, 12756.80864787029, 13058.2817945013, 13117.934410327982, 13375.33123343829, 13834.0, 11737.882621173765, 11806.822897656457, 11844.111691623162, 11943.40282985856, 12110.39448027604, 4216.409702641633, 4239.342901850218, 4269.487661480611, 4270.252705776476, 4272.209641216385, 60017.39982600205, 60111.398886011455, 60271.0, 60375.39624603742, 61326.69336653333, 10271.942582679949, 10335.17318614509, 10528.052475277262, 10566.260361774603, 10861.782764344669, 18985.43043708691, 19012.144453499626, 19052.14265358062, 19053.7141942871, 19069.427917162506, 6773.356531129535, 6892.689828957709, 6937.583744975318, 6938.861222775517, 7089.0784198053925, 3805.961940380616, 3807.5621303550447, 3808.1622043150464, 3880.9223815523533, 3895.96104038956, 2823.2377258140186, 2917.110281364162, 2919.4744945909515, 2921.97078029217, 2923.766098712098, 485.2430208874168, 502.04110149614064, 509.0379183343484, 509.06332348478236, 510.9718965456861, 489.87997940504806, 539.692375346049, 568.795233715862, 588.302746576131, 626.7305058824658, 8010.759677209693, 8717.782055448664, 8734.082921293173, 8763.649454021896, 8906.566994133573, 621.1738387944024, 635.6408629124622, 646.0, 648.7015972652538, 649.9935000650028, 3829.310724069694, 4077.9086834067175, 4174.91650167001, 4176.9582304177175, 4238.87283381499, 91262.0, 93064.0, 93183.61347478759, 96038.0, 96171.51914240383, 79940.60029699931, 80532.0, 80794.59602701949, 81129.59435202787, 82098.0, 70276.64861675659, 73333.0, 73752.63123684347, 74220.0, 74227.62886185426, 7867.881981770163, 8080.757577272691, 8092.878606820785, 8161.755147345589, 8346.081930987466, 41600.0, 41641.79179104085, 41718.58281417147, 42932.57067429286, 43217.567824322614, 45168.77415612901, 60008.0, 60339.39660603338, 60518.394816053034, 61383.38616613777, 10104.79790404173, 10341.741456463347, 10419.42693151884, 10668.466576671291, 10790.190735694698, 10652.62715804943, 10725.570977160825, 10730.73173170677, 11130.109591232844, 11231.943840280746, 9862.358946668444, 10148.644797432054, 10154.136898363722, 10312.48437578103, 10520.789584208425, 9838.508074596384, 10157.288989770941, 10206.081452669, 10373.429461379697, 10917.83623245636, 9897.50512474359, 10162.593496260066, 10407.115395191493, 10479.004494573004, 10825.945870270598, 8851.247643950337, 8886.555672216493, 8933.508657023925, 8977.506237157018, 9029.548522573976, 8477.364197685074, 8501.87247191305, 8607.612657430305, 8727.869081963649, 8890.822183556422], "value": 6494.126275045295, "unit": "score"}], "name": "dromaeo_css", "value": 6395.82305450985, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 114.0, 113.0, 111.0, 112.0, 112.0, 115.0, 113.0, 115.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 138.0, 140.0, 183.0, 130.0, 156.0, 155.0, 137.0, 189.0, 130.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 160.0, 162.0, 161.0, 162.0, 163.0, 161.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 120.0, 77.0, 76.0, 75.0, 78.0, 100.0, 77.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 120.0, 87.0, 87.0, 86.0, 120.0, 86.0, 86.0, 120.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 119.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 148.0, 147.0, 146.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 65.0, 64.0, 64.0, 66.0, 63.0, 63.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 85.0, 89.0, 86.0, 91.0, 90.0, 90.0, 93.0, 88.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 135.0, 130.0, 137.0, 133.0, 132.0, 127.0, 133.0, 149.0, 132.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 170.0, 164.0, 172.0, 164.0, 169.0, 171.0, 172.0, 171.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 67.0, 65.0, 66.0, 67.0, 66.0, 68.0, 65.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1549.0, "alertThreshold": 2.0}]} 04:18:40 INFO - Return code: 0 04:18:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:18:40 INFO - # TBPL SUCCESS # 04:18:40 INFO - Running post-action listener: _resource_record_post_action 04:18:40 INFO - ##### 04:18:40 INFO - ##### Finished run-tests step (success) 04:18:40 INFO - ##### 04:18:40 INFO - Running post-run listener: _resource_record_post_run 04:18:40 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 546275328; Read time: 168; Write time: 528236 04:18:40 INFO - TinderboxPrint: CPU usage
13.1% 04:18:40 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 168 04:18:40 INFO - TinderboxPrint: I/O write bytes / time
546,275,328 / 528,236 04:18:40 INFO - TinderboxPrint: CPU idle
8,322.8 (86.9%) 04:18:40 INFO - TinderboxPrint: CPU user
1,211.6 (12.6%) 04:18:40 INFO - TinderboxPrint: Swap in / out
0 / 0 04:18:40 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 257880064; Read time: 160; Write time: 292180 04:18:40 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288395264; Read time: 8; Write time: 236056 04:18:41 INFO - Running post-run listener: _upload_blobber_files 04:18:41 INFO - Blob upload gear active. 04:18:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:18:41 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 04:18:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:18:41 INFO - (blobuploader) - INFO - Open directory for files ... 04:18:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:18:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:18:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:18:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:18:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:18:42 INFO - (blobuploader) - INFO - Done attempting. 04:18:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:18:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:18:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:18:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:18:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:18:45 INFO - (blobuploader) - INFO - Done attempting. 04:18:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:18:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:18:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:18:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:18:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:18:46 INFO - (blobuploader) - INFO - Done attempting. 04:18:46 INFO - (blobuploader) - INFO - Iteration through files over. 04:18:46 INFO - Return code: 0 04:18:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:18:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:18:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/abee9b6969cbee8503ae5fb93ec72d28bb31b5374da2b69228140aa84c0c12a4e24778e20310a0b379ef442f501a864c1a2c29e912c6bb663b8966dd6f8d6072", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c86f6057d5981262f36bbc893a314d0e2c5b831177655f23aaa60c63e04dbf9d38a9a849cfc36a39f125eb2b61e143b7e98f6a29b034f2cee98896cedd1bced5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/643c28da1125e01ed49c548ff044380d2548e4d3933dbc0b3f6558d092198b7a1e54b8300e404749e341fdd765aac16bc16a667bbc66d39bf3f10bc55b713cd9"} 04:18:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:18:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:18:46 INFO - Contents: 04:18:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/abee9b6969cbee8503ae5fb93ec72d28bb31b5374da2b69228140aa84c0c12a4e24778e20310a0b379ef442f501a864c1a2c29e912c6bb663b8966dd6f8d6072", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c86f6057d5981262f36bbc893a314d0e2c5b831177655f23aaa60c63e04dbf9d38a9a849cfc36a39f125eb2b61e143b7e98f6a29b034f2cee98896cedd1bced5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/643c28da1125e01ed49c548ff044380d2548e4d3933dbc0b3f6558d092198b7a1e54b8300e404749e341fdd765aac16bc16a667bbc66d39bf3f10bc55b713cd9"} 04:18:46 INFO - Running post-run listener: copy_logs_to_upload_dir 04:18:46 INFO - Copying logs to upload dir... 04:18:46 INFO - mkdir: /builds/slave/test/build/upload/logs 04:18:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.332593 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-29 04:18:46.399050) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 04:18:46.402596) ========= 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=836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/abee9b6969cbee8503ae5fb93ec72d28bb31b5374da2b69228140aa84c0c12a4e24778e20310a0b379ef442f501a864c1a2c29e912c6bb663b8966dd6f8d6072", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c86f6057d5981262f36bbc893a314d0e2c5b831177655f23aaa60c63e04dbf9d38a9a849cfc36a39f125eb2b61e143b7e98f6a29b034f2cee98896cedd1bced5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/643c28da1125e01ed49c548ff044380d2548e4d3933dbc0b3f6558d092198b7a1e54b8300e404749e341fdd765aac16bc16a667bbc66d39bf3f10bc55b713cd9"} build_url:https://queue.taskcluster.net/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/dCXgivXgSVOHMG8CRRiZ1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/abee9b6969cbee8503ae5fb93ec72d28bb31b5374da2b69228140aa84c0c12a4e24778e20310a0b379ef442f501a864c1a2c29e912c6bb663b8966dd6f8d6072", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c86f6057d5981262f36bbc893a314d0e2c5b831177655f23aaa60c63e04dbf9d38a9a849cfc36a39f125eb2b61e143b7e98f6a29b034f2cee98896cedd1bced5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/643c28da1125e01ed49c548ff044380d2548e4d3933dbc0b3f6558d092198b7a1e54b8300e404749e341fdd765aac16bc16a667bbc66d39bf3f10bc55b713cd9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 04:18:46.429263) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 04:18:46.429666) ========= 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=836cfdc75598d54cb747368e000001a9-1467197884.697105-1048260653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 04:18:46.514353) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 04:18:46.514791) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 04:18:46.515128) ========= ========= Total master_lag: 0.18 =========