builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-021 starttime: 1467758879.26 results: success (0) buildid: 20160705151823 builduid: 821785e89e02451db7c402a8777a2589 revision: e08bba68cf4700aefa9c6b6e79750a396e921268 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 15:47:59.256076) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 15:47:59.256767) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 15:47:59.257319) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 15:47:59.305188) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 15:47:59.305479) ========= 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=df17445c3590ff7897617a0e00000225-1467756803.314130-965969872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 15:47:59-- 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% 46.9M=0s 2016-07-05 15:47:59 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117457 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 15:47:59.442921) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 15:47:59.443248) ========= 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=df17445c3590ff7897617a0e00000225-1467756803.314130-965969872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015937 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 15:47:59.592842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 15:47:59.593286) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e08bba68cf4700aefa9c6b6e79750a396e921268 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e08bba68cf4700aefa9c6b6e79750a396e921268 --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=df17445c3590ff7897617a0e00000225-1467756803.314130-965969872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 15:47:59,734 truncating revision to first 12 chars 2016-07-05 15:47:59,734 Setting DEBUG logging. 2016-07-05 15:47:59,734 attempt 1/10 2016-07-05 15:47:59,734 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e08bba68cf47?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 15:48:01,108 unpacking tar archive at: fx-team-e08bba68cf47/testing/mozharness/ program finished with exit code 0 elapsedTime=1.747849 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 15:48:01.364011) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 15:48:01.364311) ========= script_repo_revision: e08bba68cf4700aefa9c6b6e79750a396e921268 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 15:48:01.365153) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 15:48:01.365427) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 15:48:01.376565) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-07-05 15:48:01.376952) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1467756803.314130-965969872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:48:01 INFO - MultiFileLogger online at 20160705 15:48:01 in /builds/slave/test 15:48:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:48:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:48:01 INFO - {'append_to_log': False, 15:48:01 INFO - 'base_work_dir': '/builds/slave/test', 15:48:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:48:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:48:01 INFO - 'branch': 'Fx-Team-Non-PGO', 15:48:01 INFO - 'buildbot_json_path': 'buildprops.json', 15:48:01 INFO - 'config_files': ('talos/linux_config.py',), 15:48:01 INFO - 'default_actions': ('clobber', 15:48:01 INFO - 'read-buildbot-config', 15:48:01 INFO - 'download-and-extract', 15:48:01 INFO - 'populate-webroot', 15:48:01 INFO - 'create-virtualenv', 15:48:01 INFO - 'install', 15:48:01 INFO - 'run-tests'), 15:48:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:48:01 INFO - 'download_minidump_stackwalk': True, 15:48:01 INFO - 'download_symbols': 'ondemand', 15:48:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:48:01 INFO - 'tooltool.py': '/tools/tooltool.py', 15:48:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:48:01 INFO - '/tools/misc-python/virtualenv.py')}, 15:48:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:48:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:48:01 INFO - 'installer_path': 'installer.exe', 15:48:01 INFO - 'log_level': 'info', 15:48:01 INFO - 'log_name': 'talos', 15:48:01 INFO - 'log_to_console': True, 15:48:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:48:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:48:01 INFO - 'opt_config_files': (), 15:48:01 INFO - 'pip_index': False, 15:48:01 INFO - 'sps_profile': False, 15:48:01 INFO - 'sps_profile_interval': 0, 15:48:01 INFO - 'suite': 'dromaeojs', 15:48:01 INFO - 'system_bits': '32', 15:48:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:48:01 INFO - 'title': 'talos-linux64-ix-021', 15:48:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:48:01 INFO - 'use_talos_json': True, 15:48:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:48:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:48:01 INFO - 'work_dir': 'build'} 15:48:01 INFO - ##### 15:48:01 INFO - ##### Running clobber step. 15:48:01 INFO - ##### 15:48:01 INFO - Running pre-action listener: _resource_record_pre_action 15:48:01 INFO - Running main action method: clobber 15:48:01 INFO - rmtree: /builds/slave/test/build 15:48:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:48:02 INFO - Running post-action listener: _resource_record_post_action 15:48:02 INFO - ##### 15:48:02 INFO - ##### Finished clobber step (success) 15:48:02 INFO - ##### 15:48:02 INFO - ##### 15:48:02 INFO - ##### Running read-buildbot-config step. 15:48:02 INFO - ##### 15:48:02 INFO - Running pre-action listener: _resource_record_pre_action 15:48:02 INFO - Running main action method: read_buildbot_config 15:48:02 INFO - Using buildbot properties: 15:48:02 INFO - { 15:48:02 INFO - "project": "", 15:48:02 INFO - "product": "firefox", 15:48:02 INFO - "script_repo_revision": "production", 15:48:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:48:02 INFO - "repository": "", 15:48:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:48:02 INFO - "buildid": "20160705151823", 15:48:02 INFO - "pgo_build": "False", 15:48:02 INFO - "basedir": "/builds/slave/test", 15:48:02 INFO - "buildnumber": 1933, 15:48:02 INFO - "slavename": "talos-linux64-ix-021", 15:48:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:48:02 INFO - "platform": "ubuntu64_hw", 15:48:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:48:02 INFO - "branch": "fx-team", 15:48:02 INFO - "repo_path": "integration/fx-team", 15:48:02 INFO - "revision": "e08bba68cf4700aefa9c6b6e79750a396e921268", 15:48:02 INFO - "stage_platform": "linux64", 15:48:02 INFO - "builduid": "821785e89e02451db7c402a8777a2589", 15:48:02 INFO - "slavebuilddir": "test" 15:48:02 INFO - } 15:48:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:48:02 INFO - Running post-action listener: _resource_record_post_action 15:48:02 INFO - ##### 15:48:02 INFO - ##### Finished read-buildbot-config step (success) 15:48:02 INFO - ##### 15:48:02 INFO - ##### 15:48:02 INFO - ##### Running download-and-extract step. 15:48:02 INFO - ##### 15:48:02 INFO - Running pre-action listener: _resource_record_pre_action 15:48:02 INFO - Running main action method: download_and_extract 15:48:02 INFO - mkdir: /builds/slave/test/build/tests 15:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:48:02 INFO - https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:48:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:48:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:48:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/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 15:48:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/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 15:48:14 INFO - Downloaded 1361 bytes. 15:48:14 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:48:14 INFO - Using the following test package requirements: 15:48:14 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:48:14 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:48:14 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:48:14 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:14 INFO - u'jsshell-linux-x86_64.zip'], 15:48:14 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:48:14 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:48:14 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:48:14 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:48:14 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:48:14 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:48:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:48: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')]} 15:48:14 INFO - https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:48:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/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 15:48:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/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 15:48:19 INFO - Downloaded 22729872 bytes. 15:48:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:48:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:48:21 INFO - Return code: 0 15:48:21 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 15:48: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')]} 15:48:21 INFO - https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:48:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/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 15:48:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/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 15:48:22 INFO - Downloaded 22729872 bytes. 15:48:22 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'] 15:48:22 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 15:48:24 INFO - Return code: 0 15:48: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')]} 15:48:24 INFO - https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:48:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:48:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:48:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/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 15:48:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/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 15:48:24 INFO - Downloaded 14403333 bytes. 15:48:25 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'] 15:48:25 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 15:48:25 INFO - Return code: 0 15:48:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:25 INFO - https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:48:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/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 15:48:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/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 15:48:26 INFO - Downloaded 56469719 bytes. 15:48:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:26 INFO - mkdir: /builds/slave/test/properties 15:48:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:48:26 INFO - Writing to file /builds/slave/test/properties/build_url 15:48:26 INFO - Contents: 15:48:26 INFO - build_url:https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:27 INFO - Running post-action listener: _resource_record_post_action 15:48:27 INFO - Running post-action listener: set_extra_try_arguments 15:48:27 INFO - ##### 15:48:27 INFO - ##### Finished download-and-extract step (success) 15:48:27 INFO - ##### 15:48:27 INFO - ##### 15:48:27 INFO - ##### Running populate-webroot step. 15:48:27 INFO - ##### 15:48:27 INFO - Running pre-action listener: _resource_record_pre_action 15:48:27 INFO - Running main action method: populate_webroot 15:48:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:48:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:48:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:48:27 INFO - '--tppagecycles', 15:48:27 INFO - '7'], 15:48:27 INFO - 'tests': ['tsvgm']}}, 15:48:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:48:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:48:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:48:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:48:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:27 INFO - 'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:27 INFO - 'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['damp', 'tps']}, 15:48:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:27 INFO - 'tests': ['damp', 'tps']}, 15:48:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['dromaeo_dom']}, 15:48:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:48:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['basic_compositor_video']}, 15:48:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:48:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['a11yr', 15:48:27 INFO - 'ts_paint', 15:48:27 INFO - 'tpaint', 15:48:27 INFO - 'sessionrestore', 15:48:27 INFO - 'sessionrestore_no_auto_restore', 15:48:27 INFO - 'tabpaint']}, 15:48:27 INFO - 'other-e10s': {'tests': ['a11yr', 15:48:27 INFO - 'ts_paint', 15:48:27 INFO - 'tpaint', 15:48:27 INFO - 'sessionrestore', 15:48:27 INFO - 'sessionrestore_no_auto_restore', 15:48:27 INFO - 'tabpaint']}, 15:48:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:48:27 INFO - 'ts_paint', 15:48:27 INFO - 'tpaint', 15:48:27 INFO - 'sessionrestore', 15:48:27 INFO - 'sessionrestore_no_auto_restore', 15:48:27 INFO - 'tabpaint']}, 15:48:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:48:27 INFO - 'ts_paint', 15:48:27 INFO - 'tpaint', 15:48:27 INFO - 'sessionrestore', 15:48:27 INFO - 'sessionrestore_no_auto_restore', 15:48:27 INFO - 'tabpaint']}, 15:48:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['a11yr', 15:48:27 INFO - 'ts_paint', 15:48:27 INFO - 'tpaint', 15:48:27 INFO - 'sessionrestore', 15:48:27 INFO - 'sessionrestore_no_auto_restore', 15:48:27 INFO - 'tabpaint']}, 15:48:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['a11yr', 15:48:27 INFO - 'ts_paint', 15:48:27 INFO - 'tpaint', 15:48:27 INFO - 'sessionrestore', 15:48:27 INFO - 'sessionrestore_no_auto_restore', 15:48:27 INFO - 'tabpaint']}, 15:48:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['tsvgx', 15:48:27 INFO - 'tsvgr_opacity', 15:48:27 INFO - 'tart', 15:48:27 INFO - 'tscrollx', 15:48:27 INFO - 'cart']}, 15:48:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:48:27 INFO - 'tsvgr_opacity', 15:48:27 INFO - 'tart', 15:48:27 INFO - 'tscrollx', 15:48:27 INFO - 'cart']}, 15:48:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:27 INFO - 'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['tp5o']}, 15:48:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:27 INFO - 'tests': ['tp5o']}, 15:48:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:27 INFO - 'talos_options': ['--disable-e10s', 15:48:27 INFO - '--xperf_path', 15:48:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:27 INFO - 'tests': ['tp5n']}, 15:48:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:27 INFO - 'talos_options': ['--xperf_path', 15:48:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:27 INFO - 'tests': ['tp5n']}}, 15:48:27 INFO - 'talos.zip': {'path': '', 15:48:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:48:27 INFO - Running post-action listener: _resource_record_post_action 15:48:27 INFO - ##### 15:48:27 INFO - ##### Finished populate-webroot step (success) 15:48:27 INFO - ##### 15:48:27 INFO - ##### 15:48:27 INFO - ##### Running create-virtualenv step. 15:48:27 INFO - ##### 15:48:27 INFO - Running pre-action listener: _resource_record_pre_action 15:48:27 INFO - Running main action method: create_virtualenv 15:48:27 INFO - Creating virtualenv /builds/slave/test/build/venv 15:48:27 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 15:48:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:48:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:48:27 INFO - Using real prefix '/usr' 15:48:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:48:28 INFO - Installing distribute.............................................................................................................................................................................................done. 15:48:30 INFO - Installing pip.................done. 15:48:30 INFO - Return code: 0 15:48:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2891180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288f3b0>, '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 0x28902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2890740>, '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': 'df17445c3590ff7897617a0e00000225-1467756803.314130-965969872', '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 15:48:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:48:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:48:30 INFO - Using env: {'DISPLAY': ':0', 15:48:30 INFO - 'HOME': '/home/cltbld', 15:48:30 INFO - 'LANG': 'en_US.UTF-8', 15:48:30 INFO - 'LANGUAGE': 'en_US:en', 15:48:30 INFO - 'LOGNAME': 'cltbld', 15:48:30 INFO - 'MAIL': '/var/mail/cltbld', 15:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:30 INFO - 'MOZ_NO_REMOTE': '1', 15:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:30 INFO - 'NO_EM_RESTART': '1', 15:48:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:30 INFO - 'PWD': '/builds/slave/test', 15:48:30 INFO - 'SHELL': '/bin/bash', 15:48:30 INFO - 'SHLVL': '1', 15:48:30 INFO - 'TERM': 'linux', 15:48:30 INFO - 'TMOUT': '86400', 15:48:30 INFO - 'USER': 'cltbld', 15:48:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467756803.314130-965969872', 15:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:30 INFO - '_': '/tools/buildbot/bin/python'} 15:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:30 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 15:48:30 INFO - Cleaning up... 15:48:30 INFO - Return code: 0 15:48:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2891180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288f3b0>, '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 0x28902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2890740>, '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': 'df17445c3590ff7897617a0e00000225-1467756803.314130-965969872', '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 15:48:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:48:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:48:30 INFO - Using env: {'DISPLAY': ':0', 15:48:30 INFO - 'HOME': '/home/cltbld', 15:48:30 INFO - 'LANG': 'en_US.UTF-8', 15:48:30 INFO - 'LANGUAGE': 'en_US:en', 15:48:30 INFO - 'LOGNAME': 'cltbld', 15:48:30 INFO - 'MAIL': '/var/mail/cltbld', 15:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:30 INFO - 'MOZ_NO_REMOTE': '1', 15:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:30 INFO - 'NO_EM_RESTART': '1', 15:48:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:30 INFO - 'PWD': '/builds/slave/test', 15:48:30 INFO - 'SHELL': '/bin/bash', 15:48:30 INFO - 'SHLVL': '1', 15:48:30 INFO - 'TERM': 'linux', 15:48:30 INFO - 'TMOUT': '86400', 15:48:30 INFO - 'USER': 'cltbld', 15:48:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467756803.314130-965969872', 15:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:30 INFO - '_': '/tools/buildbot/bin/python'} 15:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:30 INFO - Downloading/unpacking psutil>=3.1.1 15:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:48:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:48:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:48:32 INFO - Installing collected packages: psutil 15:48:32 INFO - Running setup.py install for psutil 15:48:32 INFO - building 'psutil._psutil_linux' extension 15:48:32 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 15:48:32 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 15:48:32 INFO - building 'psutil._psutil_posix' extension 15:48:32 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 15:48:32 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 15:48:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:48:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:48:33 INFO - Successfully installed psutil 15:48:33 INFO - Cleaning up... 15:48:33 INFO - Return code: 0 15:48:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:48:33 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')]} 15:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:33 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')]} 15:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:33 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 0x25d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2891180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288f3b0>, '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 0x28902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2890740>, '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': 'df17445c3590ff7897617a0e00000225-1467756803.314130-965969872', '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 15:48:33 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 15:48:33 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 15:48:33 INFO - Using env: {'DISPLAY': ':0', 15:48:33 INFO - 'HOME': '/home/cltbld', 15:48:33 INFO - 'LANG': 'en_US.UTF-8', 15:48:33 INFO - 'LANGUAGE': 'en_US:en', 15:48:33 INFO - 'LOGNAME': 'cltbld', 15:48:33 INFO - 'MAIL': '/var/mail/cltbld', 15:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:33 INFO - 'MOZ_NO_REMOTE': '1', 15:48:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:33 INFO - 'NO_EM_RESTART': '1', 15:48:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:33 INFO - 'PWD': '/builds/slave/test', 15:48:33 INFO - 'SHELL': '/bin/bash', 15:48:33 INFO - 'SHLVL': '1', 15:48:33 INFO - 'TERM': 'linux', 15:48:33 INFO - 'TMOUT': '86400', 15:48:33 INFO - 'USER': 'cltbld', 15:48:33 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467756803.314130-965969872', 15:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:33 INFO - '_': '/tools/buildbot/bin/python'} 15:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:48:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:48:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:48:35 INFO - Installing collected packages: mozsystemmonitor 15:48:35 INFO - Running setup.py install for mozsystemmonitor 15:48:35 INFO - Successfully installed mozsystemmonitor 15:48:35 INFO - Cleaning up... 15:48:35 INFO - Return code: 0 15:48:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:48: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')]} 15:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48: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')]} 15:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2891180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288f3b0>, '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 0x28902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2890740>, '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': 'df17445c3590ff7897617a0e00000225-1467756803.314130-965969872', '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 15:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:48:35 INFO - Using env: {'DISPLAY': ':0', 15:48:35 INFO - 'HOME': '/home/cltbld', 15:48:35 INFO - 'LANG': 'en_US.UTF-8', 15:48:35 INFO - 'LANGUAGE': 'en_US:en', 15:48:35 INFO - 'LOGNAME': 'cltbld', 15:48:35 INFO - 'MAIL': '/var/mail/cltbld', 15:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:35 INFO - 'MOZ_NO_REMOTE': '1', 15:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:35 INFO - 'NO_EM_RESTART': '1', 15:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:35 INFO - 'PWD': '/builds/slave/test', 15:48:35 INFO - 'SHELL': '/bin/bash', 15:48:35 INFO - 'SHLVL': '1', 15:48:35 INFO - 'TERM': 'linux', 15:48:35 INFO - 'TMOUT': '86400', 15:48:35 INFO - 'USER': 'cltbld', 15:48:35 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467756803.314130-965969872', 15:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:35 INFO - '_': '/tools/buildbot/bin/python'} 15:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:35 INFO - Downloading/unpacking jsonschema==2.5.1 15:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:48:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48:37 INFO - Downloading functools32-3.2.3-2.tar.gz 15:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:48:37 INFO - warning: no files found matching '*.txt' 15:48:37 INFO - no previously-included directories found matching 'build' 15:48:37 INFO - no previously-included directories found matching 'dist' 15:48:37 INFO - no previously-included directories found matching '.git*' 15:48:37 INFO - Installing collected packages: jsonschema, functools32 15:48:37 INFO - Running setup.py install for functools32 15:48:37 INFO - warning: no files found matching '*.txt' 15:48:37 INFO - no previously-included directories found matching 'build' 15:48:37 INFO - no previously-included directories found matching 'dist' 15:48:37 INFO - no previously-included directories found matching '.git*' 15:48:37 INFO - Successfully installed jsonschema functools32 15:48:37 INFO - Cleaning up... 15:48:37 INFO - Return code: 0 15:48:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:48:37 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')]} 15:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:37 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')]} 15:48:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:37 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 0x25d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2891180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288f3b0>, '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 0x28902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2890740>, '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': 'df17445c3590ff7897617a0e00000225-1467756803.314130-965969872', '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 15:48:37 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 15:48:37 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 15:48:37 INFO - Using env: {'DISPLAY': ':0', 15:48:37 INFO - 'HOME': '/home/cltbld', 15:48:37 INFO - 'LANG': 'en_US.UTF-8', 15:48:37 INFO - 'LANGUAGE': 'en_US:en', 15:48:37 INFO - 'LOGNAME': 'cltbld', 15:48:37 INFO - 'MAIL': '/var/mail/cltbld', 15:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:37 INFO - 'MOZ_NO_REMOTE': '1', 15:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:38 INFO - 'NO_EM_RESTART': '1', 15:48:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:38 INFO - 'PWD': '/builds/slave/test', 15:48:38 INFO - 'SHELL': '/bin/bash', 15:48:38 INFO - 'SHLVL': '1', 15:48:38 INFO - 'TERM': 'linux', 15:48:38 INFO - 'TMOUT': '86400', 15:48:38 INFO - 'USER': 'cltbld', 15:48:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467756803.314130-965969872', 15:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:38 INFO - '_': '/tools/buildbot/bin/python'} 15:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:38 INFO - Downloading/unpacking blobuploader==1.2.4 15:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:40 INFO - Downloading blobuploader-1.2.4.tar.gz 15:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:48:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:48:40 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 15:48:40 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 15:48:40 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 15:48:40 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 15:48:40 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 15:48:40 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 15:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:48:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:48:40 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 15:48:40 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 15:48:40 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 15:48:40 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 15:48:40 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 15:48:40 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 15:48:40 INFO - Downloading docopt-0.6.1.tar.gz 15:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:48:40 INFO - Installing collected packages: blobuploader, requests, docopt 15:48:40 INFO - Running setup.py install for blobuploader 15:48:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:48:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:48:40 INFO - Running setup.py install for requests 15:48:41 INFO - Running setup.py install for docopt 15:48:41 INFO - Successfully installed blobuploader requests docopt 15:48:41 INFO - Cleaning up... 15:48:41 INFO - Return code: 0 15:48:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:41 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')]} 15:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:41 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')]} 15:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:41 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 0x25d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2891180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288f3b0>, '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 0x28902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2890740>, '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': 'df17445c3590ff7897617a0e00000225-1467756803.314130-965969872', '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 15:48:41 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 15:48:41 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 15:48:41 INFO - Using env: {'DISPLAY': ':0', 15:48:41 INFO - 'HOME': '/home/cltbld', 15:48:41 INFO - 'LANG': 'en_US.UTF-8', 15:48:41 INFO - 'LANGUAGE': 'en_US:en', 15:48:41 INFO - 'LOGNAME': 'cltbld', 15:48:41 INFO - 'MAIL': '/var/mail/cltbld', 15:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:41 INFO - 'MOZ_NO_REMOTE': '1', 15:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:41 INFO - 'NO_EM_RESTART': '1', 15:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:41 INFO - 'PWD': '/builds/slave/test', 15:48:41 INFO - 'SHELL': '/bin/bash', 15:48:41 INFO - 'SHLVL': '1', 15:48:41 INFO - 'TERM': 'linux', 15:48:41 INFO - 'TMOUT': '86400', 15:48:41 INFO - 'USER': 'cltbld', 15:48:41 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467756803.314130-965969872', 15:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:41 INFO - '_': '/tools/buildbot/bin/python'} 15:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:41 INFO - Running setup.py (path:/tmp/pip-pAvQD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:41 INFO - Running setup.py (path:/tmp/pip-CJoKb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:41 INFO - Running setup.py (path:/tmp/pip-dr71GA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:41 INFO - Running setup.py (path:/tmp/pip-gtDpo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:41 INFO - Running setup.py (path:/tmp/pip-TwlftY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:42 INFO - Running setup.py (path:/tmp/pip-SyX2Gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:42 INFO - Running setup.py (path:/tmp/pip-60ybgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:42 INFO - Running setup.py (path:/tmp/pip-9SaOHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:42 INFO - Running setup.py (path:/tmp/pip-EdDwwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:42 INFO - Running setup.py (path:/tmp/pip-2tVp4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:42 INFO - Running setup.py (path:/tmp/pip-0SAC8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:42 INFO - Running setup.py (path:/tmp/pip-lnvut_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:42 INFO - Running setup.py (path:/tmp/pip-kx1h_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:42 INFO - Running setup.py (path:/tmp/pip-5amoSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:42 INFO - Running setup.py (path:/tmp/pip-_KAzCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:42 INFO - Running setup.py (path:/tmp/pip-Vn5RBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:42 INFO - Running setup.py (path:/tmp/pip-laC5yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:48:42 INFO - Running setup.py install for manifestparser 15:48:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:48:42 INFO - Running setup.py install for mozcrash 15:48:43 INFO - Running setup.py install for mozdebug 15:48:43 INFO - Running setup.py install for mozdevice 15:48:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:48:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:48:43 INFO - Running setup.py install for mozfile 15:48:43 INFO - Running setup.py install for mozhttpd 15:48:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:48:43 INFO - Running setup.py install for mozinfo 15:48:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:48:43 INFO - Running setup.py install for mozInstall 15:48:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:48:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:48:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:48:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:48:43 INFO - Running setup.py install for mozleak 15:48:43 INFO - Running setup.py install for mozlog 15:48:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:48:43 INFO - Running setup.py install for moznetwork 15:48:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:48:44 INFO - Running setup.py install for mozprocess 15:48:44 INFO - Running setup.py install for mozprofile 15:48:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:48:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:48:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:48:44 INFO - Running setup.py install for mozrunner 15:48:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:48:44 INFO - Running setup.py install for mozscreenshot 15:48:44 INFO - Running setup.py install for moztest 15:48:44 INFO - Running setup.py install for mozversion 15:48:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:48:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:48:44 INFO - Cleaning up... 15:48:44 INFO - Return code: 0 15:48:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:44 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')]} 15:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:44 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')]} 15:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:44 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 0x25d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2891180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288f3b0>, '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 0x28902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2890740>, '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': 'df17445c3590ff7897617a0e00000225-1467756803.314130-965969872', '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 15:48:44 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 15:48:44 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 15:48:44 INFO - Using env: {'DISPLAY': ':0', 15:48:44 INFO - 'HOME': '/home/cltbld', 15:48:44 INFO - 'LANG': 'en_US.UTF-8', 15:48:44 INFO - 'LANGUAGE': 'en_US:en', 15:48:44 INFO - 'LOGNAME': 'cltbld', 15:48:44 INFO - 'MAIL': '/var/mail/cltbld', 15:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:44 INFO - 'MOZ_NO_REMOTE': '1', 15:48:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:44 INFO - 'NO_EM_RESTART': '1', 15:48:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:44 INFO - 'PWD': '/builds/slave/test', 15:48:44 INFO - 'SHELL': '/bin/bash', 15:48:44 INFO - 'SHLVL': '1', 15:48:44 INFO - 'TERM': 'linux', 15:48:44 INFO - 'TMOUT': '86400', 15:48:44 INFO - 'USER': 'cltbld', 15:48:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467756803.314130-965969872', 15:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:44 INFO - '_': '/tools/buildbot/bin/python'} 15:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:44 INFO - Running setup.py (path:/tmp/pip-2y7LUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:44 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)) 15:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:44 INFO - Running setup.py (path:/tmp/pip-EFGzKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:45 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)) 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:45 INFO - Running setup.py (path:/tmp/pip-ssxfIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:45 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)) 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:45 INFO - Running setup.py (path:/tmp/pip-5INwja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:45 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)) 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:45 INFO - Running setup.py (path:/tmp/pip-TwDifS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:45 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)) 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:45 INFO - Running setup.py (path:/tmp/pip-VNoBCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:45 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)) 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:45 INFO - Running setup.py (path:/tmp/pip-n5v7w0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:45 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)) 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:45 INFO - Running setup.py (path:/tmp/pip-Eev8Aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:45 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)) 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:45 INFO - Running setup.py (path:/tmp/pip-p3VpF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:45 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)) 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:45 INFO - Running setup.py (path:/tmp/pip-Db2R4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:45 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)) 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:45 INFO - Running setup.py (path:/tmp/pip-7SiJn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:45 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)) 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:45 INFO - Running setup.py (path:/tmp/pip-4bViqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:45 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)) 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:45 INFO - Running setup.py (path:/tmp/pip-3M35DV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:45 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)) 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:45 INFO - Running setup.py (path:/tmp/pip-1qyJMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:45 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)) 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:45 INFO - Running setup.py (path:/tmp/pip-7F5N6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:46 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)) 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:46 INFO - Running setup.py (path:/tmp/pip-bffMvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:46 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)) 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:46 INFO - Running setup.py (path:/tmp/pip-8PGdP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:46 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)) 15:48:46 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)) 15:48:46 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)) 15:48:46 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)) 15:48:46 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)) 15:48:46 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)) 15:48:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:48 INFO - Downloading blessings-1.6.tar.gz 15:48:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:48:48 INFO - Installing collected packages: blessings 15:48:48 INFO - Running setup.py install for blessings 15:48:48 INFO - Successfully installed blessings 15:48:48 INFO - Cleaning up... 15:48:48 INFO - Return code: 0 15:48:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:48:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:48 INFO - Reading from file tmpfile_stdout 15:48:48 INFO - Current package versions: 15:48:48 INFO - argparse == 1.2.1 15:48:48 INFO - blessings == 1.6 15:48:48 INFO - blobuploader == 1.2.4 15:48:48 INFO - docopt == 0.6.1 15:48:48 INFO - functools32 == 3.2.3-2 15:48:48 INFO - jsonschema == 2.5.1 15:48:48 INFO - manifestparser == 1.1 15:48:48 INFO - mozInstall == 1.12 15:48:48 INFO - mozcrash == 0.17 15:48:48 INFO - mozdebug == 0.1 15:48:48 INFO - mozdevice == 0.48 15:48:48 INFO - mozfile == 1.2 15:48:48 INFO - mozhttpd == 0.7 15:48:48 INFO - mozinfo == 0.9 15:48:48 INFO - mozleak == 0.1 15:48:48 INFO - mozlog == 3.2 15:48:48 INFO - moznetwork == 0.27 15:48:48 INFO - mozprocess == 0.22 15:48:48 INFO - mozprofile == 0.28 15:48:48 INFO - mozrunner == 6.11 15:48:48 INFO - mozscreenshot == 0.1 15:48:48 INFO - mozsystemmonitor == 0.3 15:48:48 INFO - moztest == 0.7 15:48:48 INFO - mozversion == 1.4 15:48:48 INFO - psutil == 3.1.1 15:48:48 INFO - requests == 1.2.3 15:48:48 INFO - wsgiref == 0.1.2 15:48:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:48 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 0x25d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2891180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288f3b0>, '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 0x28902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2890740>, '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': 'df17445c3590ff7897617a0e00000225-1467756803.314130-965969872', '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 15:48:48 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 15:48:48 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 15:48:48 INFO - Using env: {'DISPLAY': ':0', 15:48:48 INFO - 'HOME': '/home/cltbld', 15:48:48 INFO - 'LANG': 'en_US.UTF-8', 15:48:48 INFO - 'LANGUAGE': 'en_US:en', 15:48:48 INFO - 'LOGNAME': 'cltbld', 15:48:48 INFO - 'MAIL': '/var/mail/cltbld', 15:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:48 INFO - 'MOZ_NO_REMOTE': '1', 15:48:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:48 INFO - 'NO_EM_RESTART': '1', 15:48:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:48 INFO - 'PWD': '/builds/slave/test', 15:48:48 INFO - 'SHELL': '/bin/bash', 15:48:48 INFO - 'SHLVL': '1', 15:48:48 INFO - 'TERM': 'linux', 15:48:48 INFO - 'TMOUT': '86400', 15:48:48 INFO - 'USER': 'cltbld', 15:48:48 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467756803.314130-965969872', 15:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:48 INFO - '_': '/tools/buildbot/bin/python'} 15:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:48 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)) 15:48:48 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)) 15:48:48 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)) 15:48:48 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)) 15:48:48 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)) 15:48:48 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)) 15:48:48 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)) 15:48:48 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)) 15:48:48 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)) 15:48:48 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)) 15:48:48 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)) 15:48:48 INFO - Cleaning up... 15:48:48 INFO - Return code: 0 15:48:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2891180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288f3b0>, '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 0x28902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2890740>, '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': 'df17445c3590ff7897617a0e00000225-1467756803.314130-965969872', '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 15:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:48:48 INFO - Using env: {'DISPLAY': ':0', 15:48:48 INFO - 'HOME': '/home/cltbld', 15:48:48 INFO - 'LANG': 'en_US.UTF-8', 15:48:48 INFO - 'LANGUAGE': 'en_US:en', 15:48:48 INFO - 'LOGNAME': 'cltbld', 15:48:48 INFO - 'MAIL': '/var/mail/cltbld', 15:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:48 INFO - 'MOZ_NO_REMOTE': '1', 15:48:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:48 INFO - 'NO_EM_RESTART': '1', 15:48:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:48 INFO - 'PWD': '/builds/slave/test', 15:48:48 INFO - 'SHELL': '/bin/bash', 15:48:48 INFO - 'SHLVL': '1', 15:48:48 INFO - 'TERM': 'linux', 15:48:48 INFO - 'TMOUT': '86400', 15:48:48 INFO - 'USER': 'cltbld', 15:48:48 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467756803.314130-965969872', 15:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:48 INFO - '_': '/tools/buildbot/bin/python'} 15:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:48:48 INFO - Cleaning up... 15:48:48 INFO - Return code: 0 15:48:48 INFO - Running post-action listener: _resource_record_post_action 15:48:48 INFO - Running post-action listener: _start_resource_monitoring 15:48:49 INFO - Starting resource monitoring. 15:48:49 INFO - ##### 15:48:49 INFO - ##### Finished create-virtualenv step (success) 15:48:49 INFO - ##### 15:48:49 INFO - ##### 15:48:49 INFO - ##### Running install step. 15:48:49 INFO - ##### 15:48:49 INFO - Running pre-action listener: _resource_record_pre_action 15:48:49 INFO - Running main action method: install 15:48:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:49 INFO - Reading from file tmpfile_stdout 15:48:49 INFO - Detecting whether we're running mozinstall >=1.0... 15:48:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:48:49 INFO - Reading from file tmpfile_stdout 15:48:49 INFO - Output received: 15:48:49 INFO - Usage: mozinstall [options] installer 15:48:49 INFO - Options: 15:48:49 INFO - -h, --help show this help message and exit 15:48:49 INFO - -d DEST, --destination=DEST 15:48:49 INFO - Directory to install application into. [default: 15:48:49 INFO - "/builds/slave/test"] 15:48:49 INFO - --app=APP Application being installed. [default: firefox] 15:48:49 INFO - mkdir: /builds/slave/test/build/application 15:48:49 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'] 15:48:49 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 15:49:06 INFO - Reading from file tmpfile_stdout 15:49:06 INFO - Output received: 15:49:06 INFO - /builds/slave/test/build/application/firefox/firefox 15:49:06 INFO - Running post-action listener: _resource_record_post_action 15:49:06 INFO - ##### 15:49:06 INFO - ##### Finished install step (success) 15:49:06 INFO - ##### 15:49:06 INFO - ##### 15:49:06 INFO - ##### Running run-tests step. 15:49:06 INFO - ##### 15:49:06 INFO - Running pre-action listener: _resource_record_pre_action 15:49:06 INFO - Running main action method: run_tests 15:49:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:49:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:49:06 INFO - Python 2.7.3 15:49:06 INFO - Return code: 0 15:49:06 INFO - grabbing minidump binary from tooltool 15:49:06 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')]} 15:49:06 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 0x288f3b0>, '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 0x28902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2890740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:49:06 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 15:49:06 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 15:49:06 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 15:49:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:49:06 INFO - Return code: 0 15:49:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:49:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:49:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:49:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:49:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:49:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 15:49:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 15:49:06 INFO - Using env: {'DISPLAY': ':0', 15:49:06 INFO - 'HOME': '/home/cltbld', 15:49:06 INFO - 'LANG': 'en_US.UTF-8', 15:49:06 INFO - 'LANGUAGE': 'en_US:en', 15:49:06 INFO - 'LOGNAME': 'cltbld', 15:49:06 INFO - 'MAIL': '/var/mail/cltbld', 15:49:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:49:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:06 INFO - 'MOZ_NO_REMOTE': '1', 15:49:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:06 INFO - 'NO_EM_RESTART': '1', 15:49:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:06 INFO - 'PWD': '/builds/slave/test', 15:49:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:49:06 INFO - 'SHELL': '/bin/bash', 15:49:06 INFO - 'SHLVL': '1', 15:49:06 INFO - 'TERM': 'linux', 15:49:06 INFO - 'TMOUT': '86400', 15:49:06 INFO - 'USER': 'cltbld', 15:49:06 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467756803.314130-965969872', 15:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:06 INFO - '_': '/tools/buildbot/bin/python'} 15:49:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 15:49:06 INFO - mozversion application_buildid: 20160705151823 15:49:06 INFO - mozversion application_changeset: e08bba68cf4700aefa9c6b6e79750a396e921268 15:49:06 INFO - mozversion application_display_name: Nightly 15:49:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:49:06 INFO - mozversion application_name: Firefox 15:49:06 INFO - mozversion application_remotingname: firefox 15:49:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:49:06 INFO - mozversion application_vendor: Mozilla 15:49:06 INFO - mozversion application_version: 50.0a1 15:49:06 INFO - mozversion platform_buildid: 20160705151823 15:49:06 INFO - mozversion platform_changeset: e08bba68cf4700aefa9c6b6e79750a396e921268 15:49:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:49:06 INFO - mozversion platform_version: 50.0a1 15:49:06 INFO - using testdate: 1467758946 15:49:06 INFO - actual date: 1467758946 15:49:06 INFO - starting webserver on 'localhost:34524' 15:49:06 INFO - SUITE-START | Running 2 tests 15:49:06 INFO - TEST-START | dromaeo_css 15:49:06 INFO - operating with platform_type : linux_ 15:49:06 INFO - Initialising browser for dromaeo_css test... 15:49:06 INFO - TEST-INFO | started process 1448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_3CwVZ/profile http://localhost:34524/getInfo.html) 15:49:12 INFO - PROCESS | 1448 | __metrics Screen width/height:1600/1200 15:49:12 INFO - PROCESS | 1448 | colorDepth:24 15:49:12 INFO - PROCESS | 1448 | Browser inner width/height: 1024/697 15:49:12 INFO - PROCESS | 1448 | __metrics 15:49:13 INFO - PROCESS | 1448 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:49:14 INFO - TEST-INFO | 1448: exit 0 15:49:14 INFO - Browser initialized. 15:49:14 INFO - Running cycle 1/1 for dromaeo_css test... 15:49:14 INFO - TEST-INFO | started process 1530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_3CwVZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:49:26 INFO - PROCESS | 1530 | RSS: Main: 159285248 15:49:26 INFO - PROCESS | 1530 | 15:50:17 INFO - PROCESS | 1530 | 1467759017544 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] 15:52:30 INFO - PROCESS | 1530 | Cycle 1(1): loaded http://localhost:34524/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34524/tests/dromaeo/cssquery-ext.html) 15:52:32 INFO - PROCESS | 1530 | RSS: Main: 276267008 15:52:32 INFO - PROCESS | 1530 | 15:55:35 INFO - PROCESS | 1530 | Cycle 1(1): loaded http://localhost:34524/tests/dromaeo/cssquery-ext.html (next: http://localhost:34524/tests/dromaeo/cssquery-jquery.html) 15:55:35 INFO - PROCESS | 1530 | RSS: Main: 240467968 15:55:35 INFO - PROCESS | 1530 | 15:58:38 INFO - PROCESS | 1530 | Cycle 1(1): loaded http://localhost:34524/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34524/tests/dromaeo/cssquery-mootools.html) 15:58:38 INFO - PROCESS | 1530 | RSS: Main: 232341504 15:58:38 INFO - PROCESS | 1530 | 16:01:41 INFO - PROCESS | 1530 | Cycle 1(1): loaded http://localhost:34524/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34524/tests/dromaeo/cssquery-prototype.html) 16:01:41 INFO - PROCESS | 1530 | RSS: Main: 239620096 16:01:41 INFO - PROCESS | 1530 | 16:04:44 INFO - PROCESS | 1530 | Cycle 1(1): loaded http://localhost:34524/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34524/tests/dromaeo/cssquery-yui.html) 16:04:45 INFO - PROCESS | 1530 | RSS: Main: 214474752 16:04:45 INFO - PROCESS | 1530 | 16:07:48 INFO - PROCESS | 1530 | Cycle 1(1): loaded http://localhost:34524/tests/dromaeo/cssquery-yui.html (next: http://localhost:34524/tests/dromaeo/cssquery-dojo.html) 16:07:48 INFO - PROCESS | 1530 | RSS: Main: 272523264 16:07:48 INFO - PROCESS | 1530 | 16:07:48 INFO - PROCESS | 1530 | __start_tp_report 16:07:48 INFO - PROCESS | 1530 | _x_x_mozilla_page_load 16:07:48 INFO - PROCESS | 1530 | _x_x_mozilla_page_load_details 16:07:48 INFO - PROCESS | 1530 | |i|pagename|runs| 16:07:48 INFO - PROCESS | 1530 | |0;dojo.html;2630.0268900506817;2652.734726527349;2682.8658567071643;2693.9326516837077;2694.865256737163;4527.750973696446;4597.816087356502;4675.158471475133;4712.387389639346;4779.091972525222;4641;4642.698224615406;4725.8818529536775;4750.881227969294;4773.5226477352335;4073.2668119738437;4231.640310573605;4312.029793296515;4331.8700438986725;4439.5560443955665;4348.304271316574;4380.233459144652;4401.317795741649;4414.97792511037;4442.666799989997;4225.176090662322;4236.237477254093;4271.231178387889;4287.849925252633;4298.570142985708;4308.267594508941;4308.504521979981;4309.461317335333;4349.347597860315;4364.759938203398;4329.458817647794;4362.956370436286;4376.584224498668;4399.230134726442;4412.338149277602;4518.480374756912;4605.217113090749;4711.528847115295;4714.764261786897;4730.0776348612035;5025.346704928373;5035.924461133086;5086.46592107827;5097.8725531862;5103.923441148386;5091.338126043591;5108.3359163308905;5121.769520371555;5123.052235336475;5127.512886275797;4550.180967425862;4657.883552911137;4697.553732395417;4704.600108990774;4720.362751028567;5142.382914050263;5163.277141200235;5166.276721259027;5210.244514545446;5220.1647736362;4765.928511072337;4954.727489988085;4971.353724015855;5009.0232404681465;5021.573166280907;4988.825391111293;5033.697978121251;5039.21892106724;5045.394552653632;5069.417017043087;4987.925181122286;4988.925166122511;4992.151334273182;5002.2496625506465;5040.84877453677;4807.711537307773;4888.828890988798;4969.453360130383;5007.624428167902;5049;4176.895577610584;4208.158368326347;4222.641075508616;4228.175505776344;4233.25917964355;3686.078480379905;3687.520622319081;3695.648913353281;3729.776213427203;3735.7198210134347;4264.765437900884;4270.103278311527;4271.466066741657;4272.038791271939;4313.0295683471595;4892.412910450768;4960.181570040975;5021.924671129936;5029.673071250357;5053.065182941167;4254.638355739797;4273.9358909616385;4276.957230427718;4286.185624731291;4329.740215587075;4434.290513517822;4528.071745292207;4535.274356103074;4541.568550987651;4572.3827283317;4722.24444088951;4745.454272758677;4763.261694437368;4778.832740854054;4790.7844147012775;5018.297438358706;5029.119904016709;5055.266986287042;5058.1401161803315;5065.366829146356;4707.552782485658;4761.880952976203;4775.5463230993;4789.976050119727;4844.46710861812;5002.949970500248;5021.1213037717525;5042.621803364689;5045.11710450677;5092.745362731923;5100.974495127501;5119.283300337881;5126.410462796826;5128.589712822891;5139.6145289104215;4817.590504807131;4864.051509955525;4886.486918873609;4980.178270585313;4997.600191984559;4898.975505122452;4912.410510738591;4916.557509824133;4917.729524876023;4950.925736113889;4837.854864354075;4852;4891.241857512091;4894.853154405374;4899.779509922133;4803.03939212152;4828.179209534317;4847.757612119451;4858.222684370484;4885.169521181479;4744.905101898012;4786.617070634271;4805.735684537384;4815.133276010211;4815.398075240595 16:07:48 INFO - PROCESS | 1530 | |1;ext.html;538.3165373740303;576.2796504369536;583.6381443505028;589.6138029590617;594.8096609085095;26698.199054028388;40841;41451.37822932658;41490.7925460373;41536.58463415369;41642.37536436956;42084.368734469004;42104.15791684164;42139.367909481385;42144.15711685764;7553.471257012011;7880.0937892142565;8008.639611217509;10060.295779295453;10338.534765935514;10199.4390308533;10295.948520257389;10299.17606591471;10299.588016479333;10299.588016479333;10329.741756456111;10354.06813386795;10359;10359.792804143912;10405.167586593054;7753.806154846117;10179.94910025449;10318.380897146195;10374.429406382646;10386.27296089274;9923;9974.251931105196;9999.250056245737;10219.131373833234;10227.79544409115;30560;40326.193476130604;40781.941354398245;40854.1829163418;40871.182576348605;2917.081119447367;2961.052463211773;3156.921076973071;3239.8380080995857;3305.768596198267;30227.395452090834;31024.37951240985;31581.684183158333;31643.367132657448;32529.186770330696;3468.8959331220103;3593.766405183681;3627.782333060025;3685.5626305740784;3719.144596742737;273249;273842.6307868468;274286;275507;276010;53683.731581341846;58321.41678583244;58682;58972.41027589755;58994.410055898894;59944.400555994755;60914;60986.39013609896;68060.31939680639;68114;11802.94098529502;15677.843221567866;15839.52481425559;15858.365665373256;15867.682646347239;11695.181337306478;12005.699857503632;12026.939865300617;12284.631461056182;12292.446839892227;19541.09178164373;19707;19726.70409943852;19787.6254849419;19801.504962375766;7230.276972302728;7251.2807697113585;7347.448941329421;7471.8505629887095;7477.925220747832;833.8123922117475;868.9522076285739;899.9177815980241;934.5887809363858;985.8767654043245;28511.144665660064;28623.71376286252;28934;29337.413251734844;29565.669544870103;1041.4063983529468;1046.4663021858908;1048.5334026358198;1065.717584840018;1069.1233188785277;14784;14987.175705336093;15289.464868729763;15439.459618913284;15563.766543501857;374375;377852;380854;381057;382320;50203.497965020615;50668.49331506711;50786.74606627017;50795.492045079074;50839.491605084215;1057.1384321777728;1162.68607475981;1191.0174106362285;1205.4695933789105;1229.8954588860047;28022.439551208456;29610.55584166196;29653;29667.703322967358;29945.4010919776;41659.37510937278;41934.37098443587;42177;42400.78799605982;42419;293360.5331973412;295237;295793;296280;296483;32994.34011319808;37957.43063853989;38985.610143899336;39023.92688950418;41584.04951529721;42502;42514.78742606267;43212.783936080115;43351.566484334755;43634.56365436305;36259;36469;37510.43734343933;37540;37581.43627845639;36958.24734084788;37063.81468092642;37136.62863371332;37215;37496.81251593724;34978.30043399169;35666.64333356633;35831.10422239465;36368.27263454769;36419.81790091139;31488;33395.499067514495;33405.99782006544;33937;34007;25071.498570028863;25242.495150097264;25307.367315817253;25415.237542873743;25793.484130317665 16:07:48 INFO - PROCESS | 1530 | |2;jquery.html;340.82106893880723;369.72455520637124;373.69543821785226;377.14012052520263;388.30881031763454;12879.54921577745;13470.191788492684;15732.44936427224;17596.384126555542;17622.647547049084;16260.918695406535;16708.164591770423;16832.410865619706;17282.654346913056;17338.046407447586;4881.267809828528;5292.947070529303;5297.8940421191555;5300.151975683892;5301.973490132544;3758.3047136279874;5927.822165335026;6222.346653601375;6227.097070924713;6332.208473940757;6085;6292.811215663537;6302.842428939291;6317.05244213367;6321.873562528746;6227.719752611143;6277.309495955441;6282.623042617458;6313.053042043684;6318.652474113899;5383.838484845461;5389.461053894579;5459.727013649302;5468.371137319219;5508.779648814043;21045;21661.56676866454;21887.233946811943;22057.33827985163;22102.668459973112;1964.7838737738837;2016.4454774936862;2035.460602940222;2288.668143119255;2404.9298062362254;12881.67795805103;13560.932195339059;13835;14031.719365612631;14067.507637232648;1717.7595136680875;1813.5828759385283;1857.1271502393988;1863.794982551918;1865.6735071362593;44394.77802610998;54659.90680186374;55267.447325527035;61269.08096378602;72434.27565724328;8774.38579299443;9196;9906.55420506079;9992.850107248398;10062.24533160016;13142.802857957138;13574.864251357558;13633.727325453436;13643.454261829416;13653.249071300976;7569.318761311509;7608.277213664693;7608.8478230436185;7620.276073772982;7636.198199189116;7328.911260290792;7433.628318584049;7624.504407213513;7658.425618078666;7735.265149810759;6121.611127324162;6259.561830671809;6317.210348706411;6333.841653958688;6335.271443783931;1714.9742753858702;1728.196388679245;1751.4132765523439;1751.9824801752075;1763.2418060234222;888.9599968001455;922.9077092290718;930.6230976454547;946.6450081219542;950.1021534649827;17630.294788208328;18449.169787359602;18460.81539184618;18540.642420495424;18626.254949801856;889.8754174415458;912.6760000199833;917.0600134861687;987.9209663226925;1009.2380252909006;9719.271054670928;9755.268354873271;10611.734706632396;10615.89384106149;10637.255392122632;374659;403347;406625;407361;410173;80255.59872200602;85181;85266;85343;85362;894.3247847874812;902.697596305245;925.3522534226204;934.2946075712929;936.1200471556715;16216.10811405384;16356.34574617002;16378.590535236714;16383.672326553164;16538.173091345143;32092.83953580217;32720.509192361656;34277.48583771295;37571.24857502889;39602;47930.04139917252;50357.49642503528;50415.49584504108;50545;50866.491335086175;7234.457415693949;7776.377889768918;7826.2173782621285;7869.291763741291;8033.5983200838555;10362.274640775375;12144.210626309261;12344.4444999977;12363.170619101782;12443.75112497763;10186.643467478603;10564.996325349079;10754.247202695737;10913.39976301311;11043.282186657842;10346.5344059516;10637.14902807789;10738.624148154777;10839.891601083888;11094.278871873303;10211.540480678535;10254.538545765608;10284.537195826057;10723.195760318164;10772.407517586607;7525.17223105447;7615.619219038915;7615.923840761743;7812.765617031499;7891.684332626631;10055.19558435338;10165.288429809842;10252.38485690861;10646.73383165396;10822.242443028912 16:07:48 INFO - PROCESS | 1530 | |3;mootools.html;1232.3714905398244;1415.6036309833244;1429.442517418207;1553.5339398180543;1764.9911750441254;6907.30926907309;7689.884651730222;7967.16344783798;7986.041674999008;8159.265666090066;8004.91995080049;8127.227913348237;8143.877841832377;8144.389170812183;8150.307223885977;1907.8569107316937;2148.5488047510044;2235.541713948645;2262.3891549281684;2266.036934302923;2280.1563421533974;2294.3461113582634;2302;2302.7697230277004;2304.377817989142;2202.0641227478336;2226.109556177526;2233.352327824929;2234.0170325057006;2237.2057919438607;1837.4855040588657;2096.5387614724737;2158.6330323844986;2170.6526955687173;2179.455136215946;2205.680176374433;2222.8332875034275;2227.6881236626887;2227.9331620051425;2229.320057382498;8140.633671484798;8194.549299788509;8196.631151598192;8199.344052475788;8201.30288925442;4723.716577005391;4834.081524510367;4838.709677419366;4842.927356089662;4849.2968519564465;2845.6869744328105;2885.3796433766843;2975.880964761407;2981.8807247710065;2982.3438843454624;935.7613808478862;947.6162154327509;955.350361754007;961.3126614470686;961.4375590279694;10951.671449856518;10953.17851161166;10971.341719496855;10975;11013.118950483942;4092.590740925943;4212.936805947913;4352.7823608819435;4354.4992325882295;4359.06280149763;9281.21109705669;9330.533473326443;9348.158665720119;9350;9356.672516461891;4785.090832741768;4787;4794.904101917942;4800.255960326155;4801.351817504662;3717.5910649828497;4188.497380314382;4337.349397590387;4360.367746676778;4402.119576084732;3732.570754363283;3765.246950609889;3807;3842.9615703843165;3862.8261728222296;1059.597353005853;1166.8249762535688;1207.1610230889623;1213.1083653514659;1223.8837310455492;668.8628831089615;688.4458011300951;791.4697152907565;806.0327606871778;822.173715416015;5017.247412888096;5230.973845130826;5253.028189784902;5300.2049692546425;5315.468453154654;866.0559989611354;874.54960695242;887.5429153985702;895.4806212396794;896.6771962093771;3533.2580158167075;3576.803275819855;3594.7843129412317;3614.1145419371896;3664.9083772905356;9786.95106524477;10071.949640251898;10084.647037353658;10229.897701023043;10237.7440563985;10061.3901775717;10077.54651040705;10080.14318782897;10091.344062635904;10171.796564068678;7667;7702.8844567331535;7713.938552334753;7780.260875216845;7782.338501227346;5120.103981803244;5124.205748109049;5207.0366982108435;5394.08300588893;5398.703071331114;9196.540172991457;9354.25165986733;9457.33798634089;9471.47906865129;9471.715848524555;9125.406848555089;9482.146606805145;9546.18857397129;9598.136167744937;9602.183814375856;6175.258968923578;6384.265809431975;6388.329225431448;6910.20532638753;7036.542624729376;7222.422206223595;7286.96356518214;7343;7644.655990480331;7680.155182929761;6908.171019477695;6913.861722765416;6970.930290697028;7030.859382812418;7111.146662400545;6861.382475577222;7022.683979220845;7023.157221133497;7070.7525236616475;7106.360427561544;6109.694515274307;6376.936230637634;6382.36176382358;6521.347865213441;6540.869182616416;4618.122556714214;4629.166749985035;4654.837080702159;4677.760393495794;4745.810167593258;4624.3294722265755;4637.86086417408;4660.044690838302;4712.717236965793;4745.145873742621 16:07:48 INFO - PROCESS | 1530 | |4;prototype.html;305.8700052477697;306.11074827625754;308.8918878392564;310.1238999825493;310.8803110802342;4896.534829191226;4904.975475122628;4913.7788799504015;4924.729139897304;4927.187014142667;4824.445188803289;4829.637777166709;4864.6837955532865;4875.439324477687;4877.414710234777;3624.8368823402943;3751.8499260029566;3760.454734063559;3824.120452295974;3860.7876566788814;3788.374918138518;3822.159124992511;3834.980825095871;3857.6528112469873;3870.980645096771;3801.733878628497;3818;3820.3505404081234;3824.273388056274;3849.788261645608;3609.512715783375;3657.5428071491065;3792.677622402099;3799.2781371539318;3808.257389808961;3360.8741071740997;3375.3924293627138;3375.628680845105;3382.1206486313736;3386.407378708741;4755.690880092783;4781.617470602343;4784.904301913943;4790.305405716152;4793.32893394925;4208.936865947013;4353.673474489395;4369.956300436987;4372.51902290751;4392.560743925582;4982.725950072744;5021.648484606079;5026.5727413169925;5026.723530205837;5026.723530205837;3646.890593282206;3675.228202077567;3678.3562876496508;3679.1354031802507;3691.778493290384;5123.590112790967;5258.948210357982;5311.698633834735;5320.334958130234;5321.920171197435;3732.8880133596035;3752.8498860045293;3757.1546402059867;3758.361078616642;3769.589580191183;3800.657940785343;3811.485449464287;3814.809259537012;3816.8358650611276;3823.636754508317;4327.98748581911;4331.112122014979;4338.154059958341;4339.370791235253;4345.587684002712;4873.975630121898;5011.273365362075;5015.724135172601;5022.070916880316;5102.719350435762;1306.510058727977;1315.7960516120017;1319.1491487990193;1322.9735405292033;1328.6744747536916;856.8543347630917;870.3168013109679;884.8451520983803;910.6858133943779;925.9490728009889;4380.846670366522;4385.802638881258;4388.912221755547;4397.516273209944;4403.911921761547;5123.615728820353;5138.743062846843;5139.794408223704;5140.7356328730775;5142.917118566987;4244.72409293395;4372.737635741865;4377.584129507755;4377.890552736143;4383.736975781399;2766.0871912268904;2798.482280778022;2811.67665718445;2821.7443237759;2824.2233385818654;4923.458419573844;5001.874953126128;5014.974925125351;5022.271770593244;5025.296458495814;5207.479252074762;5264.676042889231;5323.547498462674;5357.946420535823;5408.702521361363;4917.680350777188;4931.8903246769905;4938.901221975612;4953.678010929278;4962.280469331999;5227.634065615523;5243.580513558983;5265.578753699771;5268.261473713742;5283.867903302448;4863.537963893425;5115.951229997767;5125.666831655931;5144.331236939174;5157.535821776059;4936.950630493793;4942.851714448572;4946.826861059845;4961.6030717543235;4963.858312588052;3817.3510503215075;3862.111714305669;3862.2661694278;3864.942025869558;3878.6509214169732;5051.949480505295;5196.220566914842;5239.794847185245;5269;5280.788768449219;5059.139946209227;5089.949100508948;5092.949070509396;5095.796168153232;5111.309973153577;5105.693658380509;5106.234064890296;5108.28484012246;5110.744462776921;5119.974400128124;4865.56209941107;5040.9918016397605;5050.449522990866;5051.52010559011;5090.847274581768;4908.582770464408;4947.505249475023;5081.23781432788;5093.675644332426;5139.434662187231;5023.070731914608;5027.572656324107;5028.969061342343;5032.949670503248;5043 16:07:48 INFO - PROCESS | 1530 | |5;yui.html;631.4979591224976;665.1552528289074;728.8250819803249;731.1664702239444;731.6780616528727;12419.379031048446;13349.799753003712;13360.265185414799;13449.932750336258;13466.663333416669;13474.5283915063;14240.430382784676;14335.068220565681;14642.633934151652;14726;621.5214285000546;791.8891355210275;804.9074356449024;811.6428771340621;812.2324403438753;763.3168314358645;793.6230290611942;796.3788245168778;797.696875187428;798.8162722573811;843.2916350265775;843.472829481574;845.5941148248844;846.2510678049908;846.504794695101;652.6834485274638;803.9316658084069;842.2083241752733;842.8482873082843;843.0052538005151;610.8472881779555;611.1749138662814;611.5382885921146;611.5841227964981;611.807280706576;13023;13118.86881131186;13134.211947283193;13138.343082845819;13181.86818131816;12942.935285323607;13287.069905106646;13327.133736307109;13434.86565134346;13436.261005644687;11422.25755325901;11486.368249746343;11496.367699776509;11508.539658413654;11613.825792613117;4253.851115210984;4272.273713468718;4275.508316543606;4280;4288.807003684841;65176.02235966512;66059.66970165167;66286.66856665735;66784;66786.66606666935;9084.954575227213;9138.451692898314;9174.495402752913;9178.173964343241;9181.219596334386;18274.725879111826;18840.623187536174;18899.149538270813;18905.7164142538;18922.67541272098;6854.10896583441;6952.270011648805;6988.615626140611;7081.964590177119;7144.785656430316;3547.875824346187;3595.334863050292;3615.855365785339;3709.9629003710156;3829.9617003829603;2939.1476471823357;3047.116336262459;3050.145959131447;3050.9847450762604;3051.6643169251365;488.79470622338704;492.9605631549539;505.4137200847;506.8656805946427;510.83142562954134;509.86998315429327;529.666310224556;544.3875639905107;544.8419958212154;553.7950958145432;6767.966160169168;7037.507374483737;7039.859202816017;7375.041244638162;7483.775486735298;429.8495526565677;490.03218643180145;517.6350672775684;521.7678133230676;527.5673947363125;3405.4891766235264;3546.219831637036;3547.592026916886;3644.599094099647;3707.443883417509;54594;54655;64031.6798416005;106231.46884265683;106962;87031;90204;93166;94319;94383.0561694388;49268.75365623149;67832.6608366955;77594;78465.21534784579;78713.21286787173;6945.374916257561;7126.964365178141;7146.285371462812;7204.819879503054;7219.061522002106;47836.52163478321;48074;48514.27228591503;51037.23444148415;51078.744606276734;63941.3605863954;70023.64988175026;70692.64653676699;71303;71767.28232717606;9216;9240.768980775534;9359.812803743751;9471.337006409485;9561.187299079656;10219.131164156284;10304.175665946555;10368.118709909742;10435.530401131815;10639.627613033506;8407.201315874981;8407.3694472916;8445.408821382443;8455.11221321777;8740.676083161372;9832.262580306362;10078.79842403133;10117.747056323651;10276.075153236245;10502.894971050497;8903.154200350957;9205.677801276923;9490.762730931781;9493.477858717837;9505.524723763645;7265.636718164176;7307.448870604034;7333.01004364404;7373.225811289737;7620.199879012624;7842.843143137219;7852.1755215703815;8062.717804876801;8123.837523249384;8178.836423271382 16:07:48 INFO - PROCESS | 1530 | __end_tp_report 16:07:48 INFO - PROCESS | 1530 | __start_cc_report 16:07:48 INFO - PROCESS | 1530 | _x_x_mozilla_cycle_collect,1136 16:07:48 INFO - PROCESS | 1530 | __end_cc_report 16:07:48 INFO - PROCESS | 1530 | __startTimestamp1467760068252__endTimestamp 16:07:48 INFO - PROCESS | 1530 | 16:07:48 INFO - PROCESS | 1530 | ------- Summary: start ------- 16:07:48 INFO - PROCESS | 1530 | Number of tests: 6 16:07:48 INFO - PROCESS | 1530 | 16:07:48 INFO - PROCESS | 1530 | [#0] dojo.html Cycles:165 Average:4647.78 Median:4778.83 stddev:492.06 (10.3%) stddev-sans-first:467.42 16:07:48 INFO - PROCESS | 1530 | Values: 2630.0 2652.7 2682.9 2693.9 2694.9 4527.8 4597.8 4675.2 4712.4 4779.1 4641.0 4642.7 4725.9 4750.9 4773.5 4073.3 4231.6 4312.0 4331.9 4439.6 4348.3 4380.2 4401.3 4415.0 4442.7 4225.2 4236.2 4271.2 4287.8 4298.6 4308.3 4308.5 4309.5 4349.3 4364.8 4329.5 4363.0 4376.6 4399.2 4412.3 4518.5 4605.2 4711.5 4714.8 4730.1 5025.3 5035.9 5086.5 5097.9 5103.9 5091.3 5108.3 5121.8 5123.1 5127.5 4550.2 4657.9 4697.6 4704.6 4720.4 5142.4 5163.3 5166.3 5210.2 5220.2 4765.9 4954.7 4971.4 5009.0 5021.6 4988.8 5033.7 5039.2 5045.4 5069.4 4987.9 4988.9 4992.2 5002.2 5040.8 4807.7 4888.8 4969.5 5007.6 5049.0 4176.9 4208.2 4222.6 4228.2 4233.3 3686.1 3687.5 3695.6 3729.8 3735.7 4264.8 4270.1 4271.5 4272.0 4313.0 4892.4 4960.2 5021.9 5029.7 5053.1 4254.6 4273.9 4277.0 4286.2 4329.7 4434.3 4528.1 4535.3 4541.6 4572.4 4722.2 4745.5 4763.3 4778.8 4790.8 5018.3 5029.1 5055.3 5058.1 5065.4 4707.6 4761.9 4775.5 4790.0 4844.5 5002.9 5021.1 5042.6 5045.1 5092.7 5101.0 5119.3 5126.4 5128.6 5139.6 4817.6 4864.1 4886.5 4980.2 4997.6 4899.0 4912.4 4916.6 4917.7 4950.9 4837.9 4852.0 4891.2 4894.9 4899.8 4803.0 4828.2 4847.8 4858.2 4885.2 4744.9 4786.6 4805.7 4815.1 4815.4 16:07:48 INFO - PROCESS | 1530 | 16:07:48 INFO - PROCESS | 1530 | [#1] ext.html Cycles:180 Average:48645.23 Median:18737.95 stddev:83772.91 (447.1%) stddev-sans-first:83930.05 16:07:48 INFO - PROCESS | 1530 | Values: 538.3 576.3 583.6 589.6 594.8 26698.2 40841.0 41451.4 41490.8 41536.6 41642.4 42084.4 42104.2 42139.4 42144.2 7553.5 7880.1 8008.6 10060.3 10338.5 10199.4 10295.9 10299.2 10299.6 10299.6 10329.7 10354.1 10359.0 10359.8 10405.2 7753.8 10179.9 10318.4 10374.4 10386.3 9923.0 9974.3 9999.3 10219.1 10227.8 30560.0 40326.2 40781.9 40854.2 40871.2 2917.1 2961.1 3156.9 3239.8 3305.8 30227.4 31024.4 31581.7 31643.4 32529.2 3468.9 3593.8 3627.8 3685.6 3719.1 273249.0 273842.6 274286.0 275507.0 276010.0 53683.7 58321.4 58682.0 58972.4 58994.4 59944.4 60914.0 60986.4 68060.3 68114.0 11802.9 15677.8 15839.5 15858.4 15867.7 11695.2 12005.7 12026.9 12284.6 12292.4 19541.1 19707.0 19726.7 19787.6 19801.5 7230.3 7251.3 7347.4 7471.9 7477.9 833.8 869.0 899.9 934.6 985.9 28511.1 28623.7 28934.0 29337.4 29565.7 1041.4 1046.5 1048.5 1065.7 1069.1 14784.0 14987.2 15289.5 15439.5 15563.8 374375.0 377852.0 380854.0 381057.0 382320.0 50203.5 50668.5 50786.7 50795.5 50839.5 1057.1 1162.7 1191.0 1205.5 1229.9 28022.4 29610.6 29653.0 29667.7 29945.4 41659.4 41934.4 42177.0 42400.8 42419.0 293360.5 295237.0 295793.0 296280.0 296483.0 32994.3 37957.4 38985.6 39023.9 41584.0 42502.0 42514.8 43212.8 43351.6 43634.6 36259.0 36469.0 37510.4 37540.0 37581.4 36958.2 37063.8 37136.6 37215.0 37496.8 34978.3 35666.6 35831.1 36368.3 36419.8 31488.0 33395.5 33406.0 33937.0 34007.0 25071.5 25242.5 25307.4 25415.2 25793.5 16:07:48 INFO - PROCESS | 1530 | 16:07:48 INFO - PROCESS | 1530 | [#2] jquery.html Cycles:180 Average:24786.20 Median:19995.15 stddev:65987.50 (330.0%) stddev-sans-first:66147.08 16:07:48 INFO - PROCESS | 1530 | Values: 340.8 369.7 373.7 377.1 388.3 12879.5 13470.2 15732.4 17596.4 17622.6 16260.9 16708.2 16832.4 17282.7 17338.0 4881.3 5292.9 5297.9 5300.2 5302.0 3758.3 5927.8 6222.3 6227.1 6332.2 6085.0 6292.8 6302.8 6317.1 6321.9 6227.7 6277.3 6282.6 6313.1 6318.7 5383.8 5389.5 5459.7 5468.4 5508.8 21045.0 21661.6 21887.2 22057.3 22102.7 1964.8 2016.4 2035.5 2288.7 2404.9 12881.7 13560.9 13835.0 14031.7 14067.5 1717.8 1813.6 1857.1 1863.8 1865.7 44394.8 54659.9 55267.4 61269.1 72434.3 8774.4 9196.0 9906.6 9992.9 10062.2 13142.8 13574.9 13633.7 13643.5 13653.2 7569.3 7608.3 7608.8 7620.3 7636.2 7328.9 7433.6 7624.5 7658.4 7735.3 6121.6 6259.6 6317.2 6333.8 6335.3 1715.0 1728.2 1751.4 1752.0 1763.2 889.0 922.9 930.6 946.6 950.1 17630.3 18449.2 18460.8 18540.6 18626.3 889.9 912.7 917.1 987.9 1009.2 9719.3 9755.3 10611.7 10615.9 10637.3 374659.0 403347.0 406625.0 407361.0 410173.0 80255.6 85181.0 85266.0 85343.0 85362.0 894.3 902.7 925.4 934.3 936.1 16216.1 16356.3 16378.6 16383.7 16538.2 32092.8 32720.5 34277.5 37571.2 39602.0 47930.0 50357.5 50415.5 50545.0 50866.5 7234.5 7776.4 7826.2 7869.3 8033.6 10362.3 12144.2 12344.4 12363.2 12443.8 10186.6 10565.0 10754.2 10913.4 11043.3 10346.5 10637.1 10738.6 10839.9 11094.3 10211.5 10254.5 10284.5 10723.2 10772.4 7525.2 7615.6 7615.9 7812.8 7891.7 10055.2 10165.3 10252.4 10646.7 10822.2 16:07:48 INFO - PROCESS | 1530 | 16:07:48 INFO - PROCESS | 1530 | [#3] mootools.html Cycles:180 Average:5277.76 Median:4836.40 stddev:3005.66 (62.1%) stddev-sans-first:2998.72 16:07:48 INFO - PROCESS | 1530 | Values: 1232.4 1415.6 1429.4 1553.5 1765.0 6907.3 7689.9 7967.2 7986.0 8159.3 8004.9 8127.2 8143.9 8144.4 8150.3 1907.9 2148.5 2235.5 2262.4 2266.0 2280.2 2294.3 2302.0 2302.8 2304.4 2202.1 2226.1 2233.4 2234.0 2237.2 1837.5 2096.5 2158.6 2170.7 2179.5 2205.7 2222.8 2227.7 2227.9 2229.3 8140.6 8194.5 8196.6 8199.3 8201.3 4723.7 4834.1 4838.7 4842.9 4849.3 2845.7 2885.4 2975.9 2981.9 2982.3 935.8 947.6 955.4 961.3 961.4 10951.7 10953.2 10971.3 10975.0 11013.1 4092.6 4212.9 4352.8 4354.5 4359.1 9281.2 9330.5 9348.2 9350.0 9356.7 4785.1 4787.0 4794.9 4800.3 4801.4 3717.6 4188.5 4337.3 4360.4 4402.1 3732.6 3765.2 3807.0 3843.0 3862.8 1059.6 1166.8 1207.2 1213.1 1223.9 668.9 688.4 791.5 806.0 822.2 5017.2 5231.0 5253.0 5300.2 5315.5 866.1 874.5 887.5 895.5 896.7 3533.3 3576.8 3594.8 3614.1 3664.9 9787.0 10071.9 10084.6 10229.9 10237.7 10061.4 10077.5 10080.1 10091.3 10171.8 7667.0 7702.9 7713.9 7780.3 7782.3 5120.1 5124.2 5207.0 5394.1 5398.7 9196.5 9354.3 9457.3 9471.5 9471.7 9125.4 9482.1 9546.2 9598.1 9602.2 6175.3 6384.3 6388.3 6910.2 7036.5 7222.4 7287.0 7343.0 7644.7 7680.2 6908.2 6913.9 6970.9 7030.9 7111.1 6861.4 7022.7 7023.2 7070.8 7106.4 6109.7 6376.9 6382.4 6521.3 6540.9 4618.1 4629.2 4654.8 4677.8 4745.8 4624.3 4637.9 4660.0 4712.7 4745.1 16:07:48 INFO - PROCESS | 1530 | 16:07:48 INFO - PROCESS | 1530 | [#4] prototype.html Cycles:180 Average:4232.75 Median:4874.71 stddev:1214.16 (24.9%) stddev-sans-first:1181.25 16:07:48 INFO - PROCESS | 1530 | Values: 305.9 306.1 308.9 310.1 310.9 4896.5 4905.0 4913.8 4924.7 4927.2 4824.4 4829.6 4864.7 4875.4 4877.4 3624.8 3751.8 3760.5 3824.1 3860.8 3788.4 3822.2 3835.0 3857.7 3871.0 3801.7 3818.0 3820.4 3824.3 3849.8 3609.5 3657.5 3792.7 3799.3 3808.3 3360.9 3375.4 3375.6 3382.1 3386.4 4755.7 4781.6 4784.9 4790.3 4793.3 4208.9 4353.7 4370.0 4372.5 4392.6 4982.7 5021.6 5026.6 5026.7 5026.7 3646.9 3675.2 3678.4 3679.1 3691.8 5123.6 5258.9 5311.7 5320.3 5321.9 3732.9 3752.8 3757.2 3758.4 3769.6 3800.7 3811.5 3814.8 3816.8 3823.6 4328.0 4331.1 4338.2 4339.4 4345.6 4874.0 5011.3 5015.7 5022.1 5102.7 1306.5 1315.8 1319.1 1323.0 1328.7 856.9 870.3 884.8 910.7 925.9 4380.8 4385.8 4388.9 4397.5 4403.9 5123.6 5138.7 5139.8 5140.7 5142.9 4244.7 4372.7 4377.6 4377.9 4383.7 2766.1 2798.5 2811.7 2821.7 2824.2 4923.5 5001.9 5015.0 5022.3 5025.3 5207.5 5264.7 5323.5 5357.9 5408.7 4917.7 4931.9 4938.9 4953.7 4962.3 5227.6 5243.6 5265.6 5268.3 5283.9 4863.5 5116.0 5125.7 5144.3 5157.5 4937.0 4942.9 4946.8 4961.6 4963.9 3817.4 3862.1 3862.3 3864.9 3878.7 5051.9 5196.2 5239.8 5269.0 5280.8 5059.1 5089.9 5092.9 5095.8 5111.3 5105.7 5106.2 5108.3 5110.7 5120.0 4865.6 5041.0 5050.4 5051.5 5090.8 4908.6 4947.5 5081.2 5093.7 5139.4 5023.1 5027.6 5029.0 5032.9 5043.0 16:07:48 INFO - PROCESS | 1530 | 16:07:48 INFO - PROCESS | 1530 | [#5] yui.html Cycles:180 Average:17301.76 Median:32286.43 stddev:25372.44 (78.6%) stddev-sans-first:25412.74 16:07:48 INFO - PROCESS | 1530 | Values: 631.5 665.2 728.8 731.2 731.7 12419.4 13349.8 13360.3 13449.9 13466.7 13474.5 14240.4 14335.1 14642.6 14726.0 621.5 791.9 804.9 811.6 812.2 763.3 793.6 796.4 797.7 798.8 843.3 843.5 845.6 846.3 846.5 652.7 803.9 842.2 842.8 843.0 610.8 611.2 611.5 611.6 611.8 13023.0 13118.9 13134.2 13138.3 13181.9 12942.9 13287.1 13327.1 13434.9 13436.3 11422.3 11486.4 11496.4 11508.5 11613.8 4253.9 4272.3 4275.5 4280.0 4288.8 65176.0 66059.7 66286.7 66784.0 66786.7 9085.0 9138.5 9174.5 9178.2 9181.2 18274.7 18840.6 18899.1 18905.7 18922.7 6854.1 6952.3 6988.6 7082.0 7144.8 3547.9 3595.3 3615.9 3710.0 3830.0 2939.1 3047.1 3050.1 3051.0 3051.7 488.8 493.0 505.4 506.9 510.8 509.9 529.7 544.4 544.8 553.8 6768.0 7037.5 7039.9 7375.0 7483.8 429.8 490.0 517.6 521.8 527.6 3405.5 3546.2 3547.6 3644.6 3707.4 54594.0 54655.0 64031.7 106231.5 106962.0 87031.0 90204.0 93166.0 94319.0 94383.1 49268.8 67832.7 77594.0 78465.2 78713.2 6945.4 7127.0 7146.3 7204.8 7219.1 47836.5 48074.0 48514.3 51037.2 51078.7 63941.4 70023.6 70692.6 71303.0 71767.3 9216.0 9240.8 9359.8 9471.3 9561.2 10219.1 10304.2 10368.1 10435.5 10639.6 8407.2 8407.4 8445.4 8455.1 8740.7 9832.3 10078.8 10117.7 10276.1 10502.9 8903.2 9205.7 9490.8 9493.5 9505.5 7265.6 7307.4 7333.0 7373.2 7620.2 7842.8 7852.2 8062.7 8123.8 8178.8 16:07:48 INFO - PROCESS | 1530 | -------- Summary: end -------- 16:07:48 INFO - PROCESS | 1530 | 16:07:49 INFO - TEST-INFO | 1530: exit 0 16:07:49 INFO - TEST-OK | dromaeo_css | took 1122494ms 16:07:49 INFO - TEST-START | kraken 16:07:49 INFO - operating with platform_type : linux_ 16:07:49 INFO - Initialising browser for kraken test... 16:07:49 INFO - TEST-INFO | started process 1721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoSUwHj/profile http://localhost:34524/getInfo.html) 16:07:53 INFO - PROCESS | 1721 | __metrics Screen width/height:1600/1200 16:07:53 INFO - PROCESS | 1721 | colorDepth:24 16:07:53 INFO - PROCESS | 1721 | Browser inner width/height: 1024/697 16:07:53 INFO - PROCESS | 1721 | __metrics 16:07:55 INFO - PROCESS | 1721 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:07:56 INFO - TEST-INFO | 1721: exit 0 16:07:56 INFO - Browser initialized. 16:07:56 INFO - Running cycle 1/1 for kraken test... 16:07:56 INFO - TEST-INFO | started process 1803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoSUwHj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:07 INFO - PROCESS | 1803 | RSS: Main: 159338496 16:08:07 INFO - PROCESS | 1803 | 16:08:10 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:34524/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34524/tests/kraken/driver.html?testName=audio-beat-detection) 16:08:11 INFO - PROCESS | 1803 | RSS: Main: 217518080 16:08:11 INFO - PROCESS | 1803 | 16:08:14 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:34524/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34524/tests/kraken/driver.html?testName=audio-dft) 16:08:14 INFO - PROCESS | 1803 | RSS: Main: 204017664 16:08:14 INFO - PROCESS | 1803 | 16:08:18 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:34524/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34524/tests/kraken/driver.html?testName=audio-fft) 16:08:18 INFO - PROCESS | 1803 | RSS: Main: 270622720 16:08:18 INFO - PROCESS | 1803 | 16:08:20 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:34524/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34524/tests/kraken/driver.html?testName=audio-oscillator) 16:08:21 INFO - PROCESS | 1803 | RSS: Main: 181891072 16:08:21 INFO - PROCESS | 1803 | 16:08:23 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:34524/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34524/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:08:24 INFO - PROCESS | 1803 | RSS: Main: 185393152 16:08:24 INFO - PROCESS | 1803 | 16:08:27 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:34524/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34524/tests/kraken/driver.html?testName=imaging-darkroom) 16:08:28 INFO - PROCESS | 1803 | RSS: Main: 221347840 16:08:28 INFO - PROCESS | 1803 | 16:08:31 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:34524/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34524/tests/kraken/driver.html?testName=imaging-desaturate) 16:08:32 INFO - PROCESS | 1803 | RSS: Main: 217194496 16:08:32 INFO - PROCESS | 1803 | 16:08:35 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:34524/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34524/tests/kraken/driver.html?testName=json-parse-financial) 16:08:35 INFO - PROCESS | 1803 | RSS: Main: 220495872 16:08:35 INFO - PROCESS | 1803 | 16:08:37 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:34524/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34524/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:08:37 INFO - PROCESS | 1803 | RSS: Main: 207798272 16:08:37 INFO - PROCESS | 1803 | 16:08:39 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:34524/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34524/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:08:40 INFO - PROCESS | 1803 | RSS: Main: 212226048 16:08:40 INFO - PROCESS | 1803 | 16:08:42 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:34524/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34524/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:08:43 INFO - PROCESS | 1803 | RSS: Main: 211337216 16:08:43 INFO - PROCESS | 1803 | 16:08:46 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:34524/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34524/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:08:46 INFO - PROCESS | 1803 | RSS: Main: 225247232 16:08:46 INFO - PROCESS | 1803 | 16:08:49 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:34524/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34524/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:08:50 INFO - PROCESS | 1803 | RSS: Main: 226770944 16:08:50 INFO - PROCESS | 1803 | 16:08:51 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:34524/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34524/tests/kraken/driver.html?testName=ai-astar) 16:08:52 INFO - PROCESS | 1803 | RSS: Main: 269627392 16:08:52 INFO - PROCESS | 1803 | 16:08:52 INFO - PROCESS | 1803 | __start_tp_report 16:08:52 INFO - PROCESS | 1803 | _x_x_mozilla_page_load 16:08:52 INFO - PROCESS | 1803 | _x_x_mozilla_page_load_details 16:08:52 INFO - PROCESS | 1803 | |i|pagename|runs| 16:08:52 INFO - PROCESS | 1803 | |0;ai-astar;103;114;112;112;112;112;112;111;112;111 16:08:52 INFO - PROCESS | 1803 | |1;audio-beat-detection;153;124;126;181;125;131;150;128;158;122 16:08:52 INFO - PROCESS | 1803 | |2;audio-dft;161;162;162;163;161;162;161;163;160;162 16:08:52 INFO - PROCESS | 1803 | |3;audio-fft;77;76;76;125;77;78;76;78;102;75 16:08:52 INFO - PROCESS | 1803 | |4;audio-oscillator;86;85;115;85;86;87;118;84;85;122 16:08:52 INFO - PROCESS | 1803 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 16:08:52 INFO - PROCESS | 1803 | |6;imaging-darkroom;147;147;146;146;146;146;147;146;146;146 16:08:52 INFO - PROCESS | 1803 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;96;95 16:08:52 INFO - PROCESS | 1803 | |8;json-parse-financial;65;65;64;64;64;65;65;64;65;64 16:08:52 INFO - PROCESS | 1803 | |9;json-stringify-tinderbox;65;65;65;65;64;65;65;65;64;66 16:08:52 INFO - PROCESS | 1803 | |10;stanford-crypto-aes;79;79;79;79;78;78;82;84;78;79 16:08:52 INFO - PROCESS | 1803 | |11;stanford-crypto-ccm;129;130;130;129;128;126;127;128;202;136 16:08:52 INFO - PROCESS | 1803 | |12;stanford-crypto-pbkdf2;164;167;164;168;177;166;167;170;166;166 16:08:52 INFO - PROCESS | 1803 | |13;stanford-crypto-sha256-iterative;67;71;68;66;67;67;69;66;67;66 16:08:52 INFO - PROCESS | 1803 | __end_tp_report 16:08:52 INFO - PROCESS | 1803 | __start_cc_report 16:08:52 INFO - PROCESS | 1803 | _x_x_mozilla_cycle_collect,1916 16:08:52 INFO - PROCESS | 1803 | __end_cc_report 16:08:52 INFO - PROCESS | 1803 | __startTimestamp1467760132178__endTimestamp 16:08:52 INFO - PROCESS | 1803 | 16:08:52 INFO - PROCESS | 1803 | ------- Summary: start ------- 16:08:52 INFO - PROCESS | 1803 | Number of tests: 14 16:08:52 INFO - PROCESS | 1803 | 16:08:52 INFO - PROCESS | 1803 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.96 (2.6%) stddev-sans-first:0.87 16:08:52 INFO - PROCESS | 1803 | Values: 103.0 114.0 112.0 112.0 112.0 112.0 112.0 111.0 112.0 111.0 16:08:52 INFO - PROCESS | 1803 | 16:08:52 INFO - PROCESS | 1803 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:140.50 stddev:19.72 (14.0%) stddev-sans-first:20.33 16:08:52 INFO - PROCESS | 1803 | Values: 153.0 124.0 126.0 181.0 125.0 131.0 150.0 128.0 158.0 122.0 16:08:52 INFO - PROCESS | 1803 | 16:08:52 INFO - PROCESS | 1803 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 16:08:52 INFO - PROCESS | 1803 | Values: 161.0 162.0 162.0 163.0 161.0 162.0 161.0 163.0 160.0 162.0 16:08:52 INFO - PROCESS | 1803 | 16:08:52 INFO - PROCESS | 1803 | [#3] audio-fft Cycles:10 Average:84.00 Median:76.50 stddev:16.49 (21.6%) stddev-sans-first:17.30 16:08:52 INFO - PROCESS | 1803 | Values: 77.0 76.0 76.0 125.0 77.0 78.0 76.0 78.0 102.0 75.0 16:08:52 INFO - PROCESS | 1803 | 16:08:52 INFO - PROCESS | 1803 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:85.00 stddev:16.00 (18.8%) stddev-sans-first:16.61 16:08:52 INFO - PROCESS | 1803 | Values: 86.0 85.0 115.0 85.0 86.0 87.0 118.0 84.0 85.0 122.0 16:08:52 INFO - PROCESS | 1803 | 16:08:52 INFO - PROCESS | 1803 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:08:52 INFO - PROCESS | 1803 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 16:08:52 INFO - PROCESS | 1803 | 16:08:52 INFO - PROCESS | 1803 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 16:08:52 INFO - PROCESS | 1803 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 16:08:52 INFO - PROCESS | 1803 | 16:08:52 INFO - PROCESS | 1803 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 16:08:52 INFO - PROCESS | 1803 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 96.0 95.0 16:08:52 INFO - PROCESS | 1803 | 16:08:52 INFO - PROCESS | 1803 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 16:08:52 INFO - PROCESS | 1803 | Values: 65.0 65.0 64.0 64.0 64.0 65.0 65.0 64.0 65.0 64.0 16:08:52 INFO - PROCESS | 1803 | 16:08:52 INFO - PROCESS | 1803 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 16:08:52 INFO - PROCESS | 1803 | Values: 65.0 65.0 65.0 65.0 64.0 65.0 65.0 65.0 64.0 66.0 16:08:52 INFO - PROCESS | 1803 | 16:08:52 INFO - PROCESS | 1803 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:1.96 (2.5%) stddev-sans-first:2.07 16:08:52 INFO - PROCESS | 1803 | Values: 79.0 79.0 79.0 79.0 78.0 78.0 82.0 84.0 78.0 79.0 16:08:52 INFO - PROCESS | 1803 | 16:08:52 INFO - PROCESS | 1803 | [#11] stanford-crypto-ccm Cycles:10 Average:136.50 Median:129.50 stddev:23.17 (17.9%) stddev-sans-first:24.42 16:08:52 INFO - PROCESS | 1803 | Values: 129.0 130.0 130.0 129.0 128.0 126.0 127.0 128.0 202.0 136.0 16:08:52 INFO - PROCESS | 1803 | 16:08:52 INFO - PROCESS | 1803 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:167.00 stddev:3.78 (2.3%) stddev-sans-first:3.79 16:08:52 INFO - PROCESS | 1803 | Values: 164.0 167.0 164.0 168.0 177.0 166.0 167.0 170.0 166.0 166.0 16:08:52 INFO - PROCESS | 1803 | 16:08:52 INFO - PROCESS | 1803 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.00 stddev:1.58 (2.4%) stddev-sans-first:1.67 16:08:52 INFO - PROCESS | 1803 | Values: 67.0 71.0 68.0 66.0 67.0 67.0 69.0 66.0 67.0 66.0 16:08:52 INFO - PROCESS | 1803 | -------- Summary: end -------- 16:08:52 INFO - PROCESS | 1803 | 16:08:53 INFO - TEST-INFO | 1803: exit 0 16:08:53 INFO - TEST-OK | kraken | took 64232ms 16:08:53 INFO - SUITE-END | took 1186s 16:08:53 INFO - Completed test suite (00:19:47) 16:08:53 INFO - javascript benchmark 16:08:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2630.0268900506817, 2652.734726527349, 2682.8658567071643, 2693.9326516837077, 2694.865256737163, 4527.750973696446, 4597.816087356502, 4675.158471475133, 4712.387389639346, 4779.091972525222, 4641.0, 4642.698224615406, 4725.8818529536775, 4750.881227969294, 4773.5226477352335, 4073.2668119738437, 4231.640310573605, 4312.029793296515, 4331.8700438986725, 4439.5560443955665, 4348.304271316574, 4380.233459144652, 4401.317795741649, 4414.97792511037, 4442.666799989997, 4225.176090662322, 4236.237477254093, 4271.231178387889, 4287.849925252633, 4298.570142985708, 4308.267594508941, 4308.504521979981, 4309.461317335333, 4349.347597860315, 4364.759938203398, 4329.458817647794, 4362.956370436286, 4376.584224498668, 4399.230134726442, 4412.338149277602, 4518.480374756912, 4605.217113090749, 4711.528847115295, 4714.764261786897, 4730.0776348612035, 5025.346704928373, 5035.924461133086, 5086.46592107827, 5097.8725531862, 5103.923441148386, 5091.338126043591, 5108.3359163308905, 5121.769520371555, 5123.052235336475, 5127.512886275797, 4550.180967425862, 4657.883552911137, 4697.553732395417, 4704.600108990774, 4720.362751028567, 5142.382914050263, 5163.277141200235, 5166.276721259027, 5210.244514545446, 5220.1647736362, 4765.928511072337, 4954.727489988085, 4971.353724015855, 5009.0232404681465, 5021.573166280907, 4988.825391111293, 5033.697978121251, 5039.21892106724, 5045.394552653632, 5069.417017043087, 4987.925181122286, 4988.925166122511, 4992.151334273182, 5002.2496625506465, 5040.84877453677, 4807.711537307773, 4888.828890988798, 4969.453360130383, 5007.624428167902, 5049.0, 4176.895577610584, 4208.158368326347, 4222.641075508616, 4228.175505776344, 4233.25917964355, 3686.078480379905, 3687.520622319081, 3695.648913353281, 3729.776213427203, 3735.7198210134347, 4264.765437900884, 4270.103278311527, 4271.466066741657, 4272.038791271939, 4313.0295683471595, 4892.412910450768, 4960.181570040975, 5021.924671129936, 5029.673071250357, 5053.065182941167, 4254.638355739797, 4273.9358909616385, 4276.957230427718, 4286.185624731291, 4329.740215587075, 4434.290513517822, 4528.071745292207, 4535.274356103074, 4541.568550987651, 4572.3827283317, 4722.24444088951, 4745.454272758677, 4763.261694437368, 4778.832740854054, 4790.7844147012775, 5018.297438358706, 5029.119904016709, 5055.266986287042, 5058.1401161803315, 5065.366829146356, 4707.552782485658, 4761.880952976203, 4775.5463230993, 4789.976050119727, 4844.46710861812, 5002.949970500248, 5021.1213037717525, 5042.621803364689, 5045.11710450677, 5092.745362731923, 5100.974495127501, 5119.283300337881, 5126.410462796826, 5128.589712822891, 5139.6145289104215, 4817.590504807131, 4864.051509955525, 4886.486918873609, 4980.178270585313, 4997.600191984559, 4898.975505122452, 4912.410510738591, 4916.557509824133, 4917.729524876023, 4950.925736113889, 4837.854864354075, 4852.0, 4891.241857512091, 4894.853154405374, 4899.779509922133, 4803.03939212152, 4828.179209534317, 4847.757612119451, 4858.222684370484, 4885.169521181479, 4744.905101898012, 4786.617070634271, 4805.735684537384, 4815.133276010211, 4815.398075240595], "value": 4616.605280211033, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.3165373740303, 576.2796504369536, 583.6381443505028, 589.6138029590617, 594.8096609085095, 26698.199054028388, 40841.0, 41451.37822932658, 41490.7925460373, 41536.58463415369, 41642.37536436956, 42084.368734469004, 42104.15791684164, 42139.367909481385, 42144.15711685764, 7553.471257012011, 7880.0937892142565, 8008.639611217509, 10060.295779295453, 10338.534765935514, 10199.4390308533, 10295.948520257389, 10299.17606591471, 10299.588016479333, 10299.588016479333, 10329.741756456111, 10354.06813386795, 10359.0, 10359.792804143912, 10405.167586593054, 7753.806154846117, 10179.94910025449, 10318.380897146195, 10374.429406382646, 10386.27296089274, 9923.0, 9974.251931105196, 9999.250056245737, 10219.131373833234, 10227.79544409115, 30560.0, 40326.193476130604, 40781.941354398245, 40854.1829163418, 40871.182576348605, 2917.081119447367, 2961.052463211773, 3156.921076973071, 3239.8380080995857, 3305.768596198267, 30227.395452090834, 31024.37951240985, 31581.684183158333, 31643.367132657448, 32529.186770330696, 3468.8959331220103, 3593.766405183681, 3627.782333060025, 3685.5626305740784, 3719.144596742737, 273249.0, 273842.6307868468, 274286.0, 275507.0, 276010.0, 53683.731581341846, 58321.41678583244, 58682.0, 58972.41027589755, 58994.410055898894, 59944.400555994755, 60914.0, 60986.39013609896, 68060.31939680639, 68114.0, 11802.94098529502, 15677.843221567866, 15839.52481425559, 15858.365665373256, 15867.682646347239, 11695.181337306478, 12005.699857503632, 12026.939865300617, 12284.631461056182, 12292.446839892227, 19541.09178164373, 19707.0, 19726.70409943852, 19787.6254849419, 19801.504962375766, 7230.276972302728, 7251.2807697113585, 7347.448941329421, 7471.8505629887095, 7477.925220747832, 833.8123922117475, 868.9522076285739, 899.9177815980241, 934.5887809363858, 985.8767654043245, 28511.144665660064, 28623.71376286252, 28934.0, 29337.413251734844, 29565.669544870103, 1041.4063983529468, 1046.4663021858908, 1048.5334026358198, 1065.717584840018, 1069.1233188785277, 14784.0, 14987.175705336093, 15289.464868729763, 15439.459618913284, 15563.766543501857, 374375.0, 377852.0, 380854.0, 381057.0, 382320.0, 50203.497965020615, 50668.49331506711, 50786.74606627017, 50795.492045079074, 50839.491605084215, 1057.1384321777728, 1162.68607475981, 1191.0174106362285, 1205.4695933789105, 1229.8954588860047, 28022.439551208456, 29610.55584166196, 29653.0, 29667.703322967358, 29945.4010919776, 41659.37510937278, 41934.37098443587, 42177.0, 42400.78799605982, 42419.0, 293360.5331973412, 295237.0, 295793.0, 296280.0, 296483.0, 32994.34011319808, 37957.43063853989, 38985.610143899336, 39023.92688950418, 41584.04951529721, 42502.0, 42514.78742606267, 43212.783936080115, 43351.566484334755, 43634.56365436305, 36259.0, 36469.0, 37510.43734343933, 37540.0, 37581.43627845639, 36958.24734084788, 37063.81468092642, 37136.62863371332, 37215.0, 37496.81251593724, 34978.30043399169, 35666.64333356633, 35831.10422239465, 36368.27263454769, 36419.81790091139, 31488.0, 33395.499067514495, 33405.99782006544, 33937.0, 34007.0, 25071.498570028863, 25242.495150097264, 25307.367315817253, 25415.237542873743, 25793.484130317665], "value": 18797.73111301258, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.82106893880723, 369.72455520637124, 373.69543821785226, 377.14012052520263, 388.30881031763454, 12879.54921577745, 13470.191788492684, 15732.44936427224, 17596.384126555542, 17622.647547049084, 16260.918695406535, 16708.164591770423, 16832.410865619706, 17282.654346913056, 17338.046407447586, 4881.267809828528, 5292.947070529303, 5297.8940421191555, 5300.151975683892, 5301.973490132544, 3758.3047136279874, 5927.822165335026, 6222.346653601375, 6227.097070924713, 6332.208473940757, 6085.0, 6292.811215663537, 6302.842428939291, 6317.05244213367, 6321.873562528746, 6227.719752611143, 6277.309495955441, 6282.623042617458, 6313.053042043684, 6318.652474113899, 5383.838484845461, 5389.461053894579, 5459.727013649302, 5468.371137319219, 5508.779648814043, 21045.0, 21661.56676866454, 21887.233946811943, 22057.33827985163, 22102.668459973112, 1964.7838737738837, 2016.4454774936862, 2035.460602940222, 2288.668143119255, 2404.9298062362254, 12881.67795805103, 13560.932195339059, 13835.0, 14031.719365612631, 14067.507637232648, 1717.7595136680875, 1813.5828759385283, 1857.1271502393988, 1863.794982551918, 1865.6735071362593, 44394.77802610998, 54659.90680186374, 55267.447325527035, 61269.08096378602, 72434.27565724328, 8774.38579299443, 9196.0, 9906.55420506079, 9992.850107248398, 10062.24533160016, 13142.802857957138, 13574.864251357558, 13633.727325453436, 13643.454261829416, 13653.249071300976, 7569.318761311509, 7608.277213664693, 7608.8478230436185, 7620.276073772982, 7636.198199189116, 7328.911260290792, 7433.628318584049, 7624.504407213513, 7658.425618078666, 7735.265149810759, 6121.611127324162, 6259.561830671809, 6317.210348706411, 6333.841653958688, 6335.271443783931, 1714.9742753858702, 1728.196388679245, 1751.4132765523439, 1751.9824801752075, 1763.2418060234222, 888.9599968001455, 922.9077092290718, 930.6230976454547, 946.6450081219542, 950.1021534649827, 17630.294788208328, 18449.169787359602, 18460.81539184618, 18540.642420495424, 18626.254949801856, 889.8754174415458, 912.6760000199833, 917.0600134861687, 987.9209663226925, 1009.2380252909006, 9719.271054670928, 9755.268354873271, 10611.734706632396, 10615.89384106149, 10637.255392122632, 374659.0, 403347.0, 406625.0, 407361.0, 410173.0, 80255.59872200602, 85181.0, 85266.0, 85343.0, 85362.0, 894.3247847874812, 902.697596305245, 925.3522534226204, 934.2946075712929, 936.1200471556715, 16216.10811405384, 16356.34574617002, 16378.590535236714, 16383.672326553164, 16538.173091345143, 32092.83953580217, 32720.509192361656, 34277.48583771295, 37571.24857502889, 39602.0, 47930.04139917252, 50357.49642503528, 50415.49584504108, 50545.0, 50866.491335086175, 7234.457415693949, 7776.377889768918, 7826.2173782621285, 7869.291763741291, 8033.5983200838555, 10362.274640775375, 12144.210626309261, 12344.4444999977, 12363.170619101782, 12443.75112497763, 10186.643467478603, 10564.996325349079, 10754.247202695737, 10913.39976301311, 11043.282186657842, 10346.5344059516, 10637.14902807789, 10738.624148154777, 10839.891601083888, 11094.278871873303, 10211.540480678535, 10254.538545765608, 10284.537195826057, 10723.195760318164, 10772.407517586607, 7525.17223105447, 7615.619219038915, 7615.923840761743, 7812.765617031499, 7891.684332626631, 10055.19558435338, 10165.288429809842, 10252.38485690861, 10646.73383165396, 10822.242443028912], "value": 8601.08617982301, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1232.3714905398244, 1415.6036309833244, 1429.442517418207, 1553.5339398180543, 1764.9911750441254, 6907.30926907309, 7689.884651730222, 7967.16344783798, 7986.041674999008, 8159.265666090066, 8004.91995080049, 8127.227913348237, 8143.877841832377, 8144.389170812183, 8150.307223885977, 1907.8569107316937, 2148.5488047510044, 2235.541713948645, 2262.3891549281684, 2266.036934302923, 2280.1563421533974, 2294.3461113582634, 2302.0, 2302.7697230277004, 2304.377817989142, 2202.0641227478336, 2226.109556177526, 2233.352327824929, 2234.0170325057006, 2237.2057919438607, 1837.4855040588657, 2096.5387614724737, 2158.6330323844986, 2170.6526955687173, 2179.455136215946, 2205.680176374433, 2222.8332875034275, 2227.6881236626887, 2227.9331620051425, 2229.320057382498, 8140.633671484798, 8194.549299788509, 8196.631151598192, 8199.344052475788, 8201.30288925442, 4723.716577005391, 4834.081524510367, 4838.709677419366, 4842.927356089662, 4849.2968519564465, 2845.6869744328105, 2885.3796433766843, 2975.880964761407, 2981.8807247710065, 2982.3438843454624, 935.7613808478862, 947.6162154327509, 955.350361754007, 961.3126614470686, 961.4375590279694, 10951.671449856518, 10953.17851161166, 10971.341719496855, 10975.0, 11013.118950483942, 4092.590740925943, 4212.936805947913, 4352.7823608819435, 4354.4992325882295, 4359.06280149763, 9281.21109705669, 9330.533473326443, 9348.158665720119, 9350.0, 9356.672516461891, 4785.090832741768, 4787.0, 4794.904101917942, 4800.255960326155, 4801.351817504662, 3717.5910649828497, 4188.497380314382, 4337.349397590387, 4360.367746676778, 4402.119576084732, 3732.570754363283, 3765.246950609889, 3807.0, 3842.9615703843165, 3862.8261728222296, 1059.597353005853, 1166.8249762535688, 1207.1610230889623, 1213.1083653514659, 1223.8837310455492, 668.8628831089615, 688.4458011300951, 791.4697152907565, 806.0327606871778, 822.173715416015, 5017.247412888096, 5230.973845130826, 5253.028189784902, 5300.2049692546425, 5315.468453154654, 866.0559989611354, 874.54960695242, 887.5429153985702, 895.4806212396794, 896.6771962093771, 3533.2580158167075, 3576.803275819855, 3594.7843129412317, 3614.1145419371896, 3664.9083772905356, 9786.95106524477, 10071.949640251898, 10084.647037353658, 10229.897701023043, 10237.7440563985, 10061.3901775717, 10077.54651040705, 10080.14318782897, 10091.344062635904, 10171.796564068678, 7667.0, 7702.8844567331535, 7713.938552334753, 7780.260875216845, 7782.338501227346, 5120.103981803244, 5124.205748109049, 5207.0366982108435, 5394.08300588893, 5398.703071331114, 9196.540172991457, 9354.25165986733, 9457.33798634089, 9471.47906865129, 9471.715848524555, 9125.406848555089, 9482.146606805145, 9546.18857397129, 9598.136167744937, 9602.183814375856, 6175.258968923578, 6384.265809431975, 6388.329225431448, 6910.20532638753, 7036.542624729376, 7222.422206223595, 7286.96356518214, 7343.0, 7644.655990480331, 7680.155182929761, 6908.171019477695, 6913.861722765416, 6970.930290697028, 7030.859382812418, 7111.146662400545, 6861.382475577222, 7022.683979220845, 7023.157221133497, 7070.7525236616475, 7106.360427561544, 6109.694515274307, 6376.936230637634, 6382.36176382358, 6521.347865213441, 6540.869182616416, 4618.122556714214, 4629.166749985035, 4654.837080702159, 4677.760393495794, 4745.810167593258, 4624.3294722265755, 4637.86086417408, 4660.044690838302, 4712.717236965793, 4745.145873742621], "value": 4218.274797981421, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.8700052477697, 306.11074827625754, 308.8918878392564, 310.1238999825493, 310.8803110802342, 4896.534829191226, 4904.975475122628, 4913.7788799504015, 4924.729139897304, 4927.187014142667, 4824.445188803289, 4829.637777166709, 4864.6837955532865, 4875.439324477687, 4877.414710234777, 3624.8368823402943, 3751.8499260029566, 3760.454734063559, 3824.120452295974, 3860.7876566788814, 3788.374918138518, 3822.159124992511, 3834.980825095871, 3857.6528112469873, 3870.980645096771, 3801.733878628497, 3818.0, 3820.3505404081234, 3824.273388056274, 3849.788261645608, 3609.512715783375, 3657.5428071491065, 3792.677622402099, 3799.2781371539318, 3808.257389808961, 3360.8741071740997, 3375.3924293627138, 3375.628680845105, 3382.1206486313736, 3386.407378708741, 4755.690880092783, 4781.617470602343, 4784.904301913943, 4790.305405716152, 4793.32893394925, 4208.936865947013, 4353.673474489395, 4369.956300436987, 4372.51902290751, 4392.560743925582, 4982.725950072744, 5021.648484606079, 5026.5727413169925, 5026.723530205837, 5026.723530205837, 3646.890593282206, 3675.228202077567, 3678.3562876496508, 3679.1354031802507, 3691.778493290384, 5123.590112790967, 5258.948210357982, 5311.698633834735, 5320.334958130234, 5321.920171197435, 3732.8880133596035, 3752.8498860045293, 3757.1546402059867, 3758.361078616642, 3769.589580191183, 3800.657940785343, 3811.485449464287, 3814.809259537012, 3816.8358650611276, 3823.636754508317, 4327.98748581911, 4331.112122014979, 4338.154059958341, 4339.370791235253, 4345.587684002712, 4873.975630121898, 5011.273365362075, 5015.724135172601, 5022.070916880316, 5102.719350435762, 1306.510058727977, 1315.7960516120017, 1319.1491487990193, 1322.9735405292033, 1328.6744747536916, 856.8543347630917, 870.3168013109679, 884.8451520983803, 910.6858133943779, 925.9490728009889, 4380.846670366522, 4385.802638881258, 4388.912221755547, 4397.516273209944, 4403.911921761547, 5123.615728820353, 5138.743062846843, 5139.794408223704, 5140.7356328730775, 5142.917118566987, 4244.72409293395, 4372.737635741865, 4377.584129507755, 4377.890552736143, 4383.736975781399, 2766.0871912268904, 2798.482280778022, 2811.67665718445, 2821.7443237759, 2824.2233385818654, 4923.458419573844, 5001.874953126128, 5014.974925125351, 5022.271770593244, 5025.296458495814, 5207.479252074762, 5264.676042889231, 5323.547498462674, 5357.946420535823, 5408.702521361363, 4917.680350777188, 4931.8903246769905, 4938.901221975612, 4953.678010929278, 4962.280469331999, 5227.634065615523, 5243.580513558983, 5265.578753699771, 5268.261473713742, 5283.867903302448, 4863.537963893425, 5115.951229997767, 5125.666831655931, 5144.331236939174, 5157.535821776059, 4936.950630493793, 4942.851714448572, 4946.826861059845, 4961.6030717543235, 4963.858312588052, 3817.3510503215075, 3862.111714305669, 3862.2661694278, 3864.942025869558, 3878.6509214169732, 5051.949480505295, 5196.220566914842, 5239.794847185245, 5269.0, 5280.788768449219, 5059.139946209227, 5089.949100508948, 5092.949070509396, 5095.796168153232, 5111.309973153577, 5105.693658380509, 5106.234064890296, 5108.28484012246, 5110.744462776921, 5119.974400128124, 4865.56209941107, 5040.9918016397605, 5050.449522990866, 5051.52010559011, 5090.847274581768, 4908.582770464408, 4947.505249475023, 5081.23781432788, 5093.675644332426, 5139.434662187231, 5023.070731914608, 5027.572656324107, 5028.969061342343, 5032.949670503248, 5043.0], "value": 3850.267294192657, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.4979591224976, 665.1552528289074, 728.8250819803249, 731.1664702239444, 731.6780616528727, 12419.379031048446, 13349.799753003712, 13360.265185414799, 13449.932750336258, 13466.663333416669, 13474.5283915063, 14240.430382784676, 14335.068220565681, 14642.633934151652, 14726.0, 621.5214285000546, 791.8891355210275, 804.9074356449024, 811.6428771340621, 812.2324403438753, 763.3168314358645, 793.6230290611942, 796.3788245168778, 797.696875187428, 798.8162722573811, 843.2916350265775, 843.472829481574, 845.5941148248844, 846.2510678049908, 846.504794695101, 652.6834485274638, 803.9316658084069, 842.2083241752733, 842.8482873082843, 843.0052538005151, 610.8472881779555, 611.1749138662814, 611.5382885921146, 611.5841227964981, 611.807280706576, 13023.0, 13118.86881131186, 13134.211947283193, 13138.343082845819, 13181.86818131816, 12942.935285323607, 13287.069905106646, 13327.133736307109, 13434.86565134346, 13436.261005644687, 11422.25755325901, 11486.368249746343, 11496.367699776509, 11508.539658413654, 11613.825792613117, 4253.851115210984, 4272.273713468718, 4275.508316543606, 4280.0, 4288.807003684841, 65176.02235966512, 66059.66970165167, 66286.66856665735, 66784.0, 66786.66606666935, 9084.954575227213, 9138.451692898314, 9174.495402752913, 9178.173964343241, 9181.219596334386, 18274.725879111826, 18840.623187536174, 18899.149538270813, 18905.7164142538, 18922.67541272098, 6854.10896583441, 6952.270011648805, 6988.615626140611, 7081.964590177119, 7144.785656430316, 3547.875824346187, 3595.334863050292, 3615.855365785339, 3709.9629003710156, 3829.9617003829603, 2939.1476471823357, 3047.116336262459, 3050.145959131447, 3050.9847450762604, 3051.6643169251365, 488.79470622338704, 492.9605631549539, 505.4137200847, 506.8656805946427, 510.83142562954134, 509.86998315429327, 529.666310224556, 544.3875639905107, 544.8419958212154, 553.7950958145432, 6767.966160169168, 7037.507374483737, 7039.859202816017, 7375.041244638162, 7483.775486735298, 429.8495526565677, 490.03218643180145, 517.6350672775684, 521.7678133230676, 527.5673947363125, 3405.4891766235264, 3546.219831637036, 3547.592026916886, 3644.599094099647, 3707.443883417509, 54594.0, 54655.0, 64031.6798416005, 106231.46884265683, 106962.0, 87031.0, 90204.0, 93166.0, 94319.0, 94383.0561694388, 49268.75365623149, 67832.6608366955, 77594.0, 78465.21534784579, 78713.21286787173, 6945.374916257561, 7126.964365178141, 7146.285371462812, 7204.819879503054, 7219.061522002106, 47836.52163478321, 48074.0, 48514.27228591503, 51037.23444148415, 51078.744606276734, 63941.3605863954, 70023.64988175026, 70692.64653676699, 71303.0, 71767.28232717606, 9216.0, 9240.768980775534, 9359.812803743751, 9471.337006409485, 9561.187299079656, 10219.131164156284, 10304.175665946555, 10368.118709909742, 10435.530401131815, 10639.627613033506, 8407.201315874981, 8407.3694472916, 8445.408821382443, 8455.11221321777, 8740.676083161372, 9832.262580306362, 10078.79842403133, 10117.747056323651, 10276.075153236245, 10502.894971050497, 8903.154200350957, 9205.677801276923, 9490.762730931781, 9493.477858717837, 9505.524723763645, 7265.636718164176, 7307.448870604034, 7333.01004364404, 7373.225811289737, 7620.199879012624, 7842.843143137219, 7852.1755215703815, 8062.717804876801, 8123.837523249384, 8178.836423271382], "value": 6263.638056775624, "unit": "score"}], "name": "dromaeo_css", "value": 6507.502831571213, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 112.0, 112.0, 112.0, 112.0, 112.0, 111.0, 112.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 126.0, 181.0, 125.0, 131.0, 150.0, 128.0, 158.0, 122.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 163.0, 161.0, 162.0, 161.0, 163.0, 160.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 125.0, 77.0, 78.0, 76.0, 78.0, 102.0, 75.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 115.0, 85.0, 86.0, 87.0, 118.0, 84.0, 85.0, 122.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 66.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 79.0, 78.0, 78.0, 82.0, 84.0, 78.0, 79.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 130.0, 130.0, 129.0, 128.0, 126.0, 127.0, 128.0, 202.0, 136.0], "value": 136.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 164.0, 168.0, 177.0, 166.0, 167.0, 170.0, 166.0, 166.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 68.0, 66.0, 67.0, 67.0, 69.0, 66.0, 67.0, 66.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1530.5000000000002, "alertThreshold": 2.0}]} 16:08:53 INFO - Return code: 0 16:08:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:08:53 INFO - # TBPL SUCCESS # 16:08:53 INFO - Running post-action listener: _resource_record_post_action 16:08:53 INFO - ##### 16:08:53 INFO - ##### Finished run-tests step (success) 16:08:53 INFO - ##### 16:08:53 INFO - Running post-run listener: _resource_record_post_run 16:08:54 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 546660352; Read time: 16; Write time: 2314936 16:08:54 INFO - TinderboxPrint: CPU usage
13.1% 16:08:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:08:54 INFO - TinderboxPrint: I/O write bytes / time
546,660,352 / 2,314,936 16:08:54 INFO - TinderboxPrint: CPU idle
8,347.3 (86.9%) 16:08:54 INFO - TinderboxPrint: CPU user
1,200.1 (12.5%) 16:08:54 INFO - TinderboxPrint: Swap in / out
0 / 0 16:08:54 INFO - install - Wall time: 17s; CPU: 23.0%; Read bytes: 0; Write bytes: 245288960; Read time: 0; Write time: 1506728 16:08:54 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 299450368; Read time: 0; Write time: 750968 16:08:54 INFO - Running post-run listener: _upload_blobber_files 16:08:54 INFO - Blob upload gear active. 16:08:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:08:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:08:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:08:55 INFO - (blobuploader) - INFO - Open directory for files ... 16:08:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:08:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:08:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:59 INFO - (blobuploader) - INFO - Done attempting. 16:08:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:08:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:08:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:59 INFO - (blobuploader) - INFO - Done attempting. 16:08:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:08:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:09:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:00 INFO - (blobuploader) - INFO - Done attempting. 16:09:00 INFO - (blobuploader) - INFO - Iteration through files over. 16:09:00 INFO - Return code: 0 16:09:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:09:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:09:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fed7d1eb977e36ab4f98fbbe48d3a191e8a84843771eca480b8fd08a56d922864154cebaa4f5ec55c64d9cff57f7e2dbd68499826b57b3d9e79f5ed16656ff2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/709926252d54aba800b96d3aa293567ba98382d50c031b6ed404e7151f800e91fb3a6ae20212064e3d7ad46529197eacc69132d78fb673e5dfbb72ff288a2e3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/259f96a5bf9f581ba01439d05fc3709882ab523e6fd0d5d7aba2faeb2d82c31f6f3b0659f6adfcfbbad3213be8bebb9e8da1267e1d0b5f34d256bc79bfc24341"} 16:09:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:09:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:09:00 INFO - Contents: 16:09:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fed7d1eb977e36ab4f98fbbe48d3a191e8a84843771eca480b8fd08a56d922864154cebaa4f5ec55c64d9cff57f7e2dbd68499826b57b3d9e79f5ed16656ff2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/709926252d54aba800b96d3aa293567ba98382d50c031b6ed404e7151f800e91fb3a6ae20212064e3d7ad46529197eacc69132d78fb673e5dfbb72ff288a2e3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/259f96a5bf9f581ba01439d05fc3709882ab523e6fd0d5d7aba2faeb2d82c31f6f3b0659f6adfcfbbad3213be8bebb9e8da1267e1d0b5f34d256bc79bfc24341"} 16:09:00 INFO - Running post-run listener: copy_logs_to_upload_dir 16:09:00 INFO - Copying logs to upload dir... 16:09:00 INFO - mkdir: /builds/slave/test/build/upload/logs 16:09:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.140027 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-07-05 16:09:00.546332) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 16:09:00.550359) ========= 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=df17445c3590ff7897617a0e00000225-1467756803.314130-965969872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fed7d1eb977e36ab4f98fbbe48d3a191e8a84843771eca480b8fd08a56d922864154cebaa4f5ec55c64d9cff57f7e2dbd68499826b57b3d9e79f5ed16656ff2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/709926252d54aba800b96d3aa293567ba98382d50c031b6ed404e7151f800e91fb3a6ae20212064e3d7ad46529197eacc69132d78fb673e5dfbb72ff288a2e3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/259f96a5bf9f581ba01439d05fc3709882ab523e6fd0d5d7aba2faeb2d82c31f6f3b0659f6adfcfbbad3213be8bebb9e8da1267e1d0b5f34d256bc79bfc24341"} build_url:https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fed7d1eb977e36ab4f98fbbe48d3a191e8a84843771eca480b8fd08a56d922864154cebaa4f5ec55c64d9cff57f7e2dbd68499826b57b3d9e79f5ed16656ff2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/709926252d54aba800b96d3aa293567ba98382d50c031b6ed404e7151f800e91fb3a6ae20212064e3d7ad46529197eacc69132d78fb673e5dfbb72ff288a2e3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/259f96a5bf9f581ba01439d05fc3709882ab523e6fd0d5d7aba2faeb2d82c31f6f3b0659f6adfcfbbad3213be8bebb9e8da1267e1d0b5f34d256bc79bfc24341"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 16:09:00.590652) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 16:09:00.591024) ========= 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=df17445c3590ff7897617a0e00000225-1467756803.314130-965969872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 16:09:00.673808) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 16:09:00.674147) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 16:09:00.674517) ========= ========= Total master_lag: 0.31 =========