builder: ash_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1449111656.15 results: success (0) buildid: 20151202172925 builduid: 5d91ba6e098f4221873c68bca4f972f5 revision: 9e8976ff699465bf1c63ce7be351402bde10be18 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 19:00:56.145353) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 19:00:56.145795) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 19:00:56.146104) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006181 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 19:00:56.168256) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 19:00:56.168541) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 19:00:56.181669) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 19:00:56.181984) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 19:00:56.230569) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 19:00:56.230885) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 19:00:56.231232) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 19:00:56.231502) ========= 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=a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-02 19:00:56-- 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% 44.0M=0s 2015-12-02 19:00:56 (44.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180514 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 19:00:56.424360) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 19:00:56.424670) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022094 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 19:00:56.473670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-02 19:00:56.474044) ========= bash -c 'python archiver_client.py mozharness --repo projects/ash --rev 9e8976ff699465bf1c63ce7be351402bde10be18 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/ash --rev 9e8976ff699465bf1c63ce7be351402bde10be18 --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=a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-02 19:00:56,514 truncating revision to first 12 chars 2015-12-02 19:00:56,514 Setting DEBUG logging. 2015-12-02 19:00:56,514 attempt 1/10 2015-12-02 19:00:56,514 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/ash/9e8976ff6994?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-02 19:00:57,507 unpacking tar archive at: ash-9e8976ff6994/testing/mozharness/ program finished with exit code 0 elapsedTime=1.571082 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-02 19:00:58.057967) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 19:00:58.058284) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 19:00:58.065641) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 19:00:58.065907) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 19:00:58.066342) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-02 19:00:58.066630) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Ash-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Ash-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', 'Ash-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Ash-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=a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:00:58 INFO - MultiFileLogger online at 20151202 19:00:58 in /builds/slave/test 19:00:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Ash-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Ash-Non-PGO 19:00:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:00:58 INFO - {'append_to_log': False, 19:00:58 INFO - 'base_work_dir': '/builds/slave/test', 19:00:58 INFO - 'blob_upload_branch': 'Ash-Non-PGO', 19:00:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:00:58 INFO - 'branch': 'Ash-Non-PGO', 19:00:58 INFO - 'buildbot_json_path': 'buildprops.json', 19:00:58 INFO - 'config_files': ('talos/linux_config.py',), 19:00:58 INFO - 'default_actions': ('clobber', 19:00:58 INFO - 'read-buildbot-config', 19:00:58 INFO - 'download-and-extract', 19:00:58 INFO - 'populate-webroot', 19:00:58 INFO - 'create-virtualenv', 19:00:58 INFO - 'install', 19:00:58 INFO - 'run-tests'), 19:00:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:00:58 INFO - 'download_minidump_stackwalk': True, 19:00:58 INFO - 'download_symbols': 'ondemand', 19:00:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:00:58 INFO - 'tooltool.py': '/tools/tooltool.py', 19:00:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:00:58 INFO - '/tools/misc-python/virtualenv.py')}, 19:00:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:00:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:00:58 INFO - 'installer_path': 'installer.exe', 19:00:58 INFO - 'log_level': 'info', 19:00:58 INFO - 'log_name': 'talos', 19:00:58 INFO - 'log_to_console': True, 19:00:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:00:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:00:58 INFO - 'opt_config_files': (), 19:00:58 INFO - 'pip_index': False, 19:00:58 INFO - 'sps_profile': False, 19:00:58 INFO - 'sps_profile_interval': 0, 19:00:58 INFO - 'suite': 'dromaeojs', 19:00:58 INFO - 'system_bits': '64', 19:00:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:00:58 INFO - 'title': 'talos-linux64-ix-026', 19:00:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:00:58 INFO - 'use_talos_json': True, 19:00:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:00:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:00:58 INFO - 'work_dir': 'build'} 19:00:58 INFO - ##### 19:00:58 INFO - ##### Running clobber step. 19:00:58 INFO - ##### 19:00:58 INFO - Running pre-action listener: _resource_record_pre_action 19:00:58 INFO - Running main action method: clobber 19:00:58 INFO - rmtree: /builds/slave/test/build 19:00:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:00:58 INFO - Running post-action listener: _resource_record_post_action 19:00:58 INFO - ##### 19:00:58 INFO - ##### Running read-buildbot-config step. 19:00:58 INFO - ##### 19:00:58 INFO - Running pre-action listener: _resource_record_pre_action 19:00:58 INFO - Running main action method: read_buildbot_config 19:00:58 INFO - Using buildbot properties: 19:00:58 INFO - { 19:00:58 INFO - "properties": { 19:00:58 INFO - "buildnumber": 1, 19:00:58 INFO - "product": "firefox", 19:00:58 INFO - "script_repo_revision": "production", 19:00:58 INFO - "builddir": "ash_ubuntu64_hw_test-dromaeojs", 19:00:58 INFO - "repository": "", 19:00:58 INFO - "buildername": "Ubuntu HW 12.04 x64 ash talos dromaeojs", 19:00:58 INFO - "buildid": "20151202172925", 19:00:58 INFO - "slavename": "talos-linux64-ix-026", 19:00:58 INFO - "pgo_build": "False", 19:00:58 INFO - "basedir": "/builds/slave/test", 19:00:58 INFO - "project": "", 19:00:58 INFO - "platform": "ubuntu64_hw", 19:00:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:00:58 INFO - "slavebuilddir": "test", 19:00:58 INFO - "scheduler": "tests-ash-linux64-talos", 19:00:58 INFO - "branch": "ash", 19:00:58 INFO - "repo_path": "projects/ash", 19:00:58 INFO - "stage_platform": "linux64", 19:00:58 INFO - "builduid": "5d91ba6e098f4221873c68bca4f972f5", 19:00:58 INFO - "revision": "9e8976ff699465bf1c63ce7be351402bde10be18" 19:00:58 INFO - }, 19:00:58 INFO - "sourcestamp": { 19:00:58 INFO - "repository": "", 19:00:58 INFO - "hasPatch": false, 19:00:58 INFO - "project": "", 19:00:58 INFO - "branch": "ash-linux64-talos", 19:00:58 INFO - "changes": [ 19:00:58 INFO - { 19:00:58 INFO - "category": null, 19:00:58 INFO - "files": [ 19:00:58 INFO - { 19:00:58 INFO - "url": null, 19:00:58 INFO - "name": "https://queue.taskcluster.net/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 19:00:58 INFO - } 19:00:58 INFO - ], 19:00:58 INFO - "repository": "", 19:00:58 INFO - "rev": "9e8976ff699465bf1c63ce7be351402bde10be18", 19:00:58 INFO - "who": "nthomas@mozilla.com", 19:00:58 INFO - "when": 1449110202, 19:00:58 INFO - "number": 6737065, 19:00:58 INFO - "comments": "Bug 1222227, one venv to rule them all", 19:00:58 INFO - "project": "", 19:00:58 INFO - "at": "Wed 02 Dec 2015 18:36:42", 19:00:58 INFO - "branch": "ash-linux64-talos", 19:00:58 INFO - "revlink": "", 19:00:58 INFO - "properties": [ 19:00:58 INFO - [ 19:00:58 INFO - "buildid", 19:00:58 INFO - "20151202172925", 19:00:58 INFO - "Change" 19:00:58 INFO - ], 19:00:58 INFO - [ 19:00:58 INFO - "builduid", 19:00:58 INFO - "5d91ba6e098f4221873c68bca4f972f5", 19:00:58 INFO - "Change" 19:00:58 INFO - ], 19:00:58 INFO - [ 19:00:58 INFO - "pgo_build", 19:00:58 INFO - "False", 19:00:58 INFO - "Change" 19:00:58 INFO - ] 19:00:58 INFO - ], 19:00:58 INFO - "revision": "9e8976ff699465bf1c63ce7be351402bde10be18" 19:00:58 INFO - } 19:00:58 INFO - ], 19:00:58 INFO - "revision": "9e8976ff699465bf1c63ce7be351402bde10be18" 19:00:58 INFO - } 19:00:58 INFO - } 19:00:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 19:00:58 INFO - Running post-action listener: _resource_record_post_action 19:00:58 INFO - ##### 19:00:58 INFO - ##### Running download-and-extract step. 19:00:58 INFO - ##### 19:00:58 INFO - Running pre-action listener: _resource_record_pre_action 19:00:58 INFO - Running main action method: download_and_extract 19:00:58 INFO - mkdir: /builds/slave/test/build/tests 19:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:00:58 INFO - https://queue.taskcluster.net/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:00:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/test_packages.json 19:00:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/test_packages.json 19:00:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:00:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:00:59 INFO - Downloaded 1302 bytes. 19:00:59 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:00:59 INFO - Using the following test package requirements: 19:00:59 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:00:59 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:59 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:00:59 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:59 INFO - u'jsshell-linux-x86_64.zip'], 19:00:59 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:59 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:00:59 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:00:59 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:59 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:00:59 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:59 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:00:59 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:59 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:00:59 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:00:59 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:59 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:00:59 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:00:59 INFO - https://queue.taskcluster.net/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:00:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:00:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:00:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:00:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:01:00 INFO - Downloaded 21345020 bytes. 19:01:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 19:01:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:01:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:01:01 INFO - Return code: 0 19:01:01 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:01 INFO - https://queue.taskcluster.net/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:01:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:01:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:01:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:01:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:01:03 INFO - Downloaded 21345020 bytes. 19:01:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 19:01:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:01:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:01:04 INFO - Return code: 0 19:01:04 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')]} 19:01:04 INFO - https://queue.taskcluster.net/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:01:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:01:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:01:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:01:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:01:05 INFO - Downloaded 11131717 bytes. 19:01:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 19:01:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:01:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 19:01:05 INFO - Return code: 0 19:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:01:05 INFO - https://queue.taskcluster.net/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:01:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:01:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:01:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:01:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:01:08 INFO - Downloaded 52114900 bytes. 19:01:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:01:08 INFO - mkdir: /builds/slave/test/properties 19:01:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:01:08 INFO - Writing to file /builds/slave/test/properties/build_url 19:01:08 INFO - Contents: 19:01:08 INFO - build_url:https://queue.taskcluster.net/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:01:08 INFO - Running post-action listener: _resource_record_post_action 19:01:08 INFO - Running post-action listener: set_extra_try_arguments 19:01:08 INFO - ##### 19:01:08 INFO - ##### Running populate-webroot step. 19:01:08 INFO - ##### 19:01:08 INFO - Running pre-action listener: _resource_record_pre_action 19:01:08 INFO - Running main action method: populate_webroot 19:01:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:01:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:01:08 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 19:01:08 INFO - '../fennec_ids.txt'], 19:01:08 INFO - 'tests': ['tcheck2']}, 19:01:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:01:08 INFO - '--tppagecycles', 19:01:08 INFO - '7'], 19:01:08 INFO - 'tests': ['tsvgm']}}, 19:01:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:01:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:01:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:01:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:01:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:01:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:01:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:01:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:08 INFO - 'talos_options': ['--e10s'], 19:01:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:01:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:08 INFO - 'tests': ['damp', 'tps']}, 19:01:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:08 INFO - 'talos_options': ['--e10s'], 19:01:08 INFO - 'tests': ['damp', 'tps']}, 19:01:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:01:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:01:08 INFO - 'other': {'tests': ['a11yr', 19:01:08 INFO - 'ts_paint', 19:01:08 INFO - 'tpaint', 19:01:08 INFO - 'sessionrestore', 19:01:08 INFO - 'sessionrestore_no_auto_restore']}, 19:01:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:01:08 INFO - 'tests': ['a11yr', 19:01:08 INFO - 'ts_paint', 19:01:08 INFO - 'tpaint', 19:01:08 INFO - 'sessionrestore', 19:01:08 INFO - 'sessionrestore_no_auto_restore']}, 19:01:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:01:08 INFO - 'tests': ['a11yr', 19:01:08 INFO - 'ts_paint', 19:01:08 INFO - 'tpaint', 19:01:08 INFO - 'sessionrestore', 19:01:08 INFO - 'sessionrestore_no_auto_restore']}, 19:01:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:01:08 INFO - 'tests': ['a11yr', 19:01:08 INFO - 'ts_paint', 19:01:08 INFO - 'tpaint', 19:01:08 INFO - 'sessionrestore', 19:01:08 INFO - 'sessionrestore_no_auto_restore']}, 19:01:08 INFO - 'other_l64': {'tests': ['a11yr', 19:01:08 INFO - 'ts_paint', 19:01:08 INFO - 'tpaint', 19:01:08 INFO - 'sessionrestore', 19:01:08 INFO - 'sessionrestore_no_auto_restore']}, 19:01:08 INFO - 'other_nol64': {'tests': ['a11yr', 19:01:08 INFO - 'ts_paint', 19:01:08 INFO - 'tpaint', 19:01:08 INFO - 'sessionrestore', 19:01:08 INFO - 'sessionrestore_no_auto_restore']}, 19:01:08 INFO - 'svgr': {'tests': ['tsvgx', 19:01:08 INFO - 'tsvgr_opacity', 19:01:08 INFO - 'tart', 19:01:08 INFO - 'tscrollx', 19:01:08 INFO - 'cart']}, 19:01:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:01:08 INFO - 'tests': ['tsvgx', 19:01:08 INFO - 'tsvgr_opacity', 19:01:08 INFO - 'tart', 19:01:08 INFO - 'tscrollx', 19:01:08 INFO - 'cart']}, 19:01:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:08 INFO - 'tests': ['tp5o']}, 19:01:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:08 INFO - 'talos_options': ['--e10s'], 19:01:08 INFO - 'tests': ['tp5o']}, 19:01:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:08 INFO - 'talos_options': ['--xperf_path', 19:01:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:01:08 INFO - 'tests': ['tp5n']}, 19:01:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:08 INFO - 'talos_options': ['--e10s', 19:01:08 INFO - '--xperf_path', 19:01:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:01:08 INFO - 'tests': ['tp5n']}}, 19:01:08 INFO - 'talos.zip': {'path': '', 19:01:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:01:08 INFO - Running post-action listener: _resource_record_post_action 19:01:08 INFO - ##### 19:01:08 INFO - ##### Running create-virtualenv step. 19:01:08 INFO - ##### 19:01:08 INFO - Running pre-action listener: _resource_record_pre_action 19:01:08 INFO - Running main action method: create_virtualenv 19:01:08 INFO - Creating virtualenv /builds/slave/test/build/venv 19:01:08 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 19:01:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:01:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:01:08 INFO - Using real prefix '/usr' 19:01:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:01:08 INFO - Installing distribute.............................................................................................................................................................................................done. 19:01:10 INFO - Installing pip.................done. 19:01:10 INFO - Return code: 0 19:01:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:01:10 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')]} 19:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:10 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')]} 19:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x1e7e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20af210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2141220>, '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 0x20ad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ad740>, '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': 'a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977', '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 19:01:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 19:01:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 19:01:10 INFO - Using env: {'DISPLAY': ':0', 19:01:10 INFO - 'HOME': '/home/cltbld', 19:01:10 INFO - 'LANG': 'en_US.UTF-8', 19:01:10 INFO - 'LANGUAGE': 'en_US:en', 19:01:10 INFO - 'LOGNAME': 'cltbld', 19:01:10 INFO - 'MAIL': '/var/mail/cltbld', 19:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:10 INFO - 'MOZ_NO_REMOTE': '1', 19:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:10 INFO - 'NO_EM_RESTART': '1', 19:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:10 INFO - 'PWD': '/builds/slave/test', 19:01:10 INFO - 'SHELL': '/bin/bash', 19:01:10 INFO - 'SHLVL': '1', 19:01:10 INFO - 'TERM': 'linux', 19:01:10 INFO - 'TMOUT': '86400', 19:01:10 INFO - 'USER': 'cltbld', 19:01:10 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977', 19:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:10 INFO - '_': '/tools/buildbot/bin/python'} 19:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:10 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 19:01:10 INFO - Cleaning up... 19:01:10 INFO - Return code: 0 19:01:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:01:10 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')]} 19:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:10 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')]} 19:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20af210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2141220>, '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 0x20ad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ad740>, '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': 'a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977', '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 19:01:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1'] in /builds/slave/test/build 19:01:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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>=0.7.1 19:01:10 INFO - Using env: {'DISPLAY': ':0', 19:01:10 INFO - 'HOME': '/home/cltbld', 19:01:10 INFO - 'LANG': 'en_US.UTF-8', 19:01:10 INFO - 'LANGUAGE': 'en_US:en', 19:01:10 INFO - 'LOGNAME': 'cltbld', 19:01:10 INFO - 'MAIL': '/var/mail/cltbld', 19:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:10 INFO - 'MOZ_NO_REMOTE': '1', 19:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:10 INFO - 'NO_EM_RESTART': '1', 19:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:10 INFO - 'PWD': '/builds/slave/test', 19:01:10 INFO - 'SHELL': '/bin/bash', 19:01:10 INFO - 'SHLVL': '1', 19:01:10 INFO - 'TERM': 'linux', 19:01:10 INFO - 'TMOUT': '86400', 19:01:10 INFO - 'USER': 'cltbld', 19:01:10 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977', 19:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:10 INFO - '_': '/tools/buildbot/bin/python'} 19:01:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:11 INFO - Downloading/unpacking psutil>=0.7.1 19:01:11 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 19:01:11 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 19:01:11 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 19:01:11 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 19:01:11 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 19:01:11 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 19:01:12 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:01:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:01:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:01:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:01:12 INFO - Installing collected packages: psutil 19:01:12 INFO - Running setup.py install for psutil 19:01:13 INFO - building 'psutil._psutil_linux' extension 19:01:13 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 19:01:13 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 19:01:13 INFO - building 'psutil._psutil_posix' extension 19:01:13 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 19:01:13 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 19:01:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:01:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:01:13 INFO - Successfully installed psutil 19:01:13 INFO - Cleaning up... 19:01:14 INFO - Return code: 0 19:01:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:01: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')]} 19:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01: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')]} 19:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20af210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2141220>, '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 0x20ad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ad740>, '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': 'a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977', '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 19:01:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0'] in /builds/slave/test/build 19:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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.0.0 19:01:14 INFO - Using env: {'DISPLAY': ':0', 19:01:14 INFO - 'HOME': '/home/cltbld', 19:01:14 INFO - 'LANG': 'en_US.UTF-8', 19:01:14 INFO - 'LANGUAGE': 'en_US:en', 19:01:14 INFO - 'LOGNAME': 'cltbld', 19:01:14 INFO - 'MAIL': '/var/mail/cltbld', 19:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:14 INFO - 'MOZ_NO_REMOTE': '1', 19:01:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:14 INFO - 'NO_EM_RESTART': '1', 19:01:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:14 INFO - 'PWD': '/builds/slave/test', 19:01:14 INFO - 'SHELL': '/bin/bash', 19:01:14 INFO - 'SHLVL': '1', 19:01:14 INFO - 'TERM': 'linux', 19:01:14 INFO - 'TMOUT': '86400', 19:01:14 INFO - 'USER': 'cltbld', 19:01:14 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977', 19:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:14 INFO - '_': '/tools/buildbot/bin/python'} 19:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:01:14 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 19:01:14 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 19:01:14 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 19:01:14 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 19:01:14 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 19:01:14 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 19:01:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:01:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:01:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:01:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:01:16 INFO - Installing collected packages: mozsystemmonitor 19:01:16 INFO - Running setup.py install for mozsystemmonitor 19:01:16 INFO - Successfully installed mozsystemmonitor 19:01:16 INFO - Cleaning up... 19:01:16 INFO - Return code: 0 19:01:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x1e7e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20af210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2141220>, '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 0x20ad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ad740>, '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': 'a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977', '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 19:01:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 19:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 19:01:16 INFO - Using env: {'DISPLAY': ':0', 19:01:16 INFO - 'HOME': '/home/cltbld', 19:01:16 INFO - 'LANG': 'en_US.UTF-8', 19:01:16 INFO - 'LANGUAGE': 'en_US:en', 19:01:16 INFO - 'LOGNAME': 'cltbld', 19:01:16 INFO - 'MAIL': '/var/mail/cltbld', 19:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:16 INFO - 'MOZ_NO_REMOTE': '1', 19:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:16 INFO - 'NO_EM_RESTART': '1', 19:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:16 INFO - 'PWD': '/builds/slave/test', 19:01:16 INFO - 'SHELL': '/bin/bash', 19:01:16 INFO - 'SHLVL': '1', 19:01:16 INFO - 'TERM': 'linux', 19:01:16 INFO - 'TMOUT': '86400', 19:01:16 INFO - 'USER': 'cltbld', 19:01:16 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977', 19:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:16 INFO - '_': '/tools/buildbot/bin/python'} 19:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:16 INFO - Downloading/unpacking blobuploader==1.2.4 19:01:16 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 19:01:16 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 19:01:16 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 19:01:16 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 19:01:16 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 19:01:16 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 19:01:18 INFO - Downloading blobuploader-1.2.4.tar.gz 19:01:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:01:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:01:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:01:18 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 19:01:18 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 19:01:18 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 19:01:18 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 19:01:18 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 19:01:18 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 19:01:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:01:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:01:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:01:19 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 19:01:19 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 19:01:19 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 19:01:19 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 19:01:19 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 19:01:19 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 19:01:19 INFO - Downloading docopt-0.6.1.tar.gz 19:01:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:01:19 INFO - Installing collected packages: blobuploader, requests, docopt 19:01:19 INFO - Running setup.py install for blobuploader 19:01:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:01:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:01:19 INFO - Running setup.py install for requests 19:01:19 INFO - Running setup.py install for docopt 19:01:19 INFO - Successfully installed blobuploader requests docopt 19:01:19 INFO - Cleaning up... 19:01:19 INFO - Return code: 0 19:01:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x1e7e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20af210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2141220>, '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 0x20ad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ad740>, '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': 'a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977', '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 19:01:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 19:01:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 19:01:19 INFO - Using env: {'DISPLAY': ':0', 19:01:19 INFO - 'HOME': '/home/cltbld', 19:01:19 INFO - 'LANG': 'en_US.UTF-8', 19:01:19 INFO - 'LANGUAGE': 'en_US:en', 19:01:19 INFO - 'LOGNAME': 'cltbld', 19:01:19 INFO - 'MAIL': '/var/mail/cltbld', 19:01:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:19 INFO - 'MOZ_NO_REMOTE': '1', 19:01:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:19 INFO - 'NO_EM_RESTART': '1', 19:01:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:19 INFO - 'PWD': '/builds/slave/test', 19:01:19 INFO - 'SHELL': '/bin/bash', 19:01:19 INFO - 'SHLVL': '1', 19:01:19 INFO - 'TERM': 'linux', 19:01:19 INFO - 'TMOUT': '86400', 19:01:19 INFO - 'USER': 'cltbld', 19:01:19 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977', 19:01:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:19 INFO - '_': '/tools/buildbot/bin/python'} 19:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:01:20 INFO - Running setup.py (path:/tmp/pip-vjXdAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:01:20 INFO - Running setup.py (path:/tmp/pip-OBiGqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:01:20 INFO - Running setup.py (path:/tmp/pip-QiTLhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:01:20 INFO - Running setup.py (path:/tmp/pip-xPdoHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:01:20 INFO - Running setup.py (path:/tmp/pip-CVBxOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:01:20 INFO - Running setup.py (path:/tmp/pip-8ZZvWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:01:20 INFO - Running setup.py (path:/tmp/pip-mZBJpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:01:20 INFO - Running setup.py (path:/tmp/pip-Ykw79E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:01:20 INFO - Running setup.py (path:/tmp/pip-VUisDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:01:20 INFO - Running setup.py (path:/tmp/pip-AGbncg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:01:20 INFO - Running setup.py (path:/tmp/pip-Cm7kzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:01:20 INFO - Running setup.py (path:/tmp/pip-4B6wcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:01:20 INFO - Running setup.py (path:/tmp/pip-ITuz2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:01:21 INFO - Running setup.py (path:/tmp/pip-j91Vvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:01:21 INFO - Running setup.py (path:/tmp/pip-1zLUeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:01:21 INFO - Running setup.py (path:/tmp/pip-mOJd5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:01:21 INFO - Running setup.py (path:/tmp/pip-w5usrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:01:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:01:21 INFO - Running setup.py install for manifestparser 19:01:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:01:21 INFO - Running setup.py install for mozcrash 19:01:21 INFO - Running setup.py install for mozdebug 19:01:21 INFO - Running setup.py install for mozdevice 19:01:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:01:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:01:21 INFO - Running setup.py install for mozfile 19:01:21 INFO - Running setup.py install for mozhttpd 19:01:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:01:21 INFO - Running setup.py install for mozinfo 19:01:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:01:22 INFO - Running setup.py install for mozInstall 19:01:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:01:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:01:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:01:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:01:22 INFO - Running setup.py install for mozleak 19:01:22 INFO - Running setup.py install for mozlog 19:01:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:01:22 INFO - Running setup.py install for moznetwork 19:01:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:01:22 INFO - Running setup.py install for mozprocess 19:01:22 INFO - Running setup.py install for mozprofile 19:01:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:01:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:01:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:01:22 INFO - Running setup.py install for mozrunner 19:01:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:01:22 INFO - Running setup.py install for mozscreenshot 19:01:22 INFO - Running setup.py install for moztest 19:01:23 INFO - Running setup.py install for mozversion 19:01:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:01:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:01:23 INFO - Cleaning up... 19:01:23 INFO - Return code: 0 19:01:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:01:23 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')]} 19:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:23 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')]} 19:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x1e7e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20af210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2141220>, '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 0x20ad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ad740>, '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': 'a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977', '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 19:01:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 19:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 19:01:23 INFO - Using env: {'DISPLAY': ':0', 19:01:23 INFO - 'HOME': '/home/cltbld', 19:01:23 INFO - 'LANG': 'en_US.UTF-8', 19:01:23 INFO - 'LANGUAGE': 'en_US:en', 19:01:23 INFO - 'LOGNAME': 'cltbld', 19:01:23 INFO - 'MAIL': '/var/mail/cltbld', 19:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:23 INFO - 'MOZ_NO_REMOTE': '1', 19:01:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:23 INFO - 'NO_EM_RESTART': '1', 19:01:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:23 INFO - 'PWD': '/builds/slave/test', 19:01:23 INFO - 'SHELL': '/bin/bash', 19:01:23 INFO - 'SHLVL': '1', 19:01:23 INFO - 'TERM': 'linux', 19:01:23 INFO - 'TMOUT': '86400', 19:01:23 INFO - 'USER': 'cltbld', 19:01:23 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977', 19:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:23 INFO - '_': '/tools/buildbot/bin/python'} 19:01:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:01:23 INFO - Running setup.py (path:/tmp/pip-cm8YR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:01:23 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)) 19:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:01:23 INFO - Running setup.py (path:/tmp/pip-0kzgv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 19:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:01:23 INFO - Running setup.py (path:/tmp/pip-zeXs2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:01:23 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)) 19:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:01:23 INFO - Running setup.py (path:/tmp/pip-QG0FjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 19:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:01:23 INFO - Running setup.py (path:/tmp/pip-o3mvMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:01:23 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)) 19:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:01:23 INFO - Running setup.py (path:/tmp/pip-x1PBKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:01:23 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)) 19:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:01:23 INFO - Running setup.py (path:/tmp/pip-ov1tAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:01:23 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)) 19:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:01:23 INFO - Running setup.py (path:/tmp/pip-jyHHFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:01:23 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)) 19:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:01:23 INFO - Running setup.py (path:/tmp/pip-XslJIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:01:23 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)) 19:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:01:23 INFO - Running setup.py (path:/tmp/pip-muXHhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 19:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:01:24 INFO - Running setup.py (path:/tmp/pip-Hk7qIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:01:24 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)) 19:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:01:24 INFO - Running setup.py (path:/tmp/pip-jg2Vns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:01:24 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)) 19:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:01:24 INFO - Running setup.py (path:/tmp/pip-oVgwEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 19:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:01:24 INFO - Running setup.py (path:/tmp/pip-nEIls6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:01:24 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)) 19:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:01:24 INFO - Running setup.py (path:/tmp/pip-_e_LWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:01:24 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)) 19:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:01:24 INFO - Running setup.py (path:/tmp/pip-herSaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:01:24 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)) 19:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:01:24 INFO - Running setup.py (path:/tmp/pip-6ciG4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:01:24 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)) 19:01:24 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:01:24 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:01:24 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)) 19:01:24 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:01:24 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:01:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:26 INFO - Downloading blessings-1.5.1.tar.gz 19:01:26 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 19:01:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:01:26 INFO - Installing collected packages: blessings 19:01:26 INFO - Running setup.py install for blessings 19:01:26 INFO - Successfully installed blessings 19:01:26 INFO - Cleaning up... 19:01:26 INFO - Return code: 0 19:01:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:01:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:01:26 INFO - Reading from file tmpfile_stdout 19:01:26 INFO - Current package versions: 19:01:26 INFO - argparse == 1.2.1 19:01:26 INFO - blessings == 1.5.1 19:01:26 INFO - blobuploader == 1.2.4 19:01:26 INFO - docopt == 0.6.1 19:01:26 INFO - manifestparser == 1.1 19:01:26 INFO - mozInstall == 1.12 19:01:26 INFO - mozcrash == 0.16 19:01:26 INFO - mozdebug == 0.1 19:01:26 INFO - mozdevice == 0.47 19:01:26 INFO - mozfile == 1.2 19:01:26 INFO - mozhttpd == 0.7 19:01:26 INFO - mozinfo == 0.9 19:01:26 INFO - mozleak == 0.1 19:01:26 INFO - mozlog == 3.1 19:01:26 INFO - moznetwork == 0.27 19:01:26 INFO - mozprocess == 0.22 19:01:26 INFO - mozprofile == 0.27 19:01:26 INFO - mozrunner == 6.11 19:01:26 INFO - mozscreenshot == 0.1 19:01:26 INFO - mozsystemmonitor == 0.0 19:01:26 INFO - moztest == 0.7 19:01:26 INFO - mozversion == 1.4 19:01:26 INFO - psutil == 3.1.1 19:01:26 INFO - requests == 1.2.3 19:01:26 INFO - wsgiref == 0.1.2 19:01:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:01:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x1e7e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20af210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2141220>, '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 0x20ad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ad740>, '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': 'a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977', '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 19:01:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 19:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 19:01:26 INFO - Using env: {'DISPLAY': ':0', 19:01:26 INFO - 'HOME': '/home/cltbld', 19:01:26 INFO - 'LANG': 'en_US.UTF-8', 19:01:26 INFO - 'LANGUAGE': 'en_US:en', 19:01:26 INFO - 'LOGNAME': 'cltbld', 19:01:26 INFO - 'MAIL': '/var/mail/cltbld', 19:01:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:26 INFO - 'MOZ_NO_REMOTE': '1', 19:01:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:26 INFO - 'NO_EM_RESTART': '1', 19:01:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:26 INFO - 'PWD': '/builds/slave/test', 19:01:26 INFO - 'SHELL': '/bin/bash', 19:01:26 INFO - 'SHLVL': '1', 19:01:26 INFO - 'TERM': 'linux', 19:01:26 INFO - 'TMOUT': '86400', 19:01:26 INFO - 'USER': 'cltbld', 19:01:26 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977', 19:01:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:26 INFO - '_': '/tools/buildbot/bin/python'} 19:01:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:26 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 1)) 19:01:26 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 2)) 19:01:26 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 3)) 19:01:26 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 4)) 19:01:26 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 5)) 19:01:26 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 6)) 19:01:26 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 7)) 19:01:26 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 8)) 19:01:26 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:01:26 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 3)) 19:01:26 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:01:26 INFO - Cleaning up... 19:01:26 INFO - Return code: 0 19:01:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:01:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x1e7e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20af210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2141220>, '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 0x20ad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ad740>, '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': 'a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977', '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 19:01:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 19:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 19:01:26 INFO - Using env: {'DISPLAY': ':0', 19:01:26 INFO - 'HOME': '/home/cltbld', 19:01:26 INFO - 'LANG': 'en_US.UTF-8', 19:01:26 INFO - 'LANGUAGE': 'en_US:en', 19:01:26 INFO - 'LOGNAME': 'cltbld', 19:01:26 INFO - 'MAIL': '/var/mail/cltbld', 19:01:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:26 INFO - 'MOZ_NO_REMOTE': '1', 19:01:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:26 INFO - 'NO_EM_RESTART': '1', 19:01:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:26 INFO - 'PWD': '/builds/slave/test', 19:01:26 INFO - 'SHELL': '/bin/bash', 19:01:26 INFO - 'SHLVL': '1', 19:01:26 INFO - 'TERM': 'linux', 19:01:26 INFO - 'TMOUT': '86400', 19:01:26 INFO - 'USER': 'cltbld', 19:01:26 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977', 19:01:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:26 INFO - '_': '/tools/buildbot/bin/python'} 19:01:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:27 INFO - Downloading/unpacking jsonschema 19:01:27 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 19:01:27 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 19:01:27 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 19:01:27 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 19:01:27 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 19:01:27 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 19:01:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:01:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 19:01:28 INFO - Downloading/unpacking functools32 (from jsonschema) 19:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:28 INFO - Downloading functools32-3.2.3-2.tar.gz 19:01:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:01:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:01:29 INFO - warning: no files found matching '*.txt' 19:01:29 INFO - no previously-included directories found matching 'build' 19:01:29 INFO - no previously-included directories found matching 'dist' 19:01:29 INFO - no previously-included directories found matching '.git*' 19:01:29 INFO - Installing collected packages: jsonschema, functools32 19:01:29 INFO - Running setup.py install for functools32 19:01:29 INFO - warning: no files found matching '*.txt' 19:01:29 INFO - no previously-included directories found matching 'build' 19:01:29 INFO - no previously-included directories found matching 'dist' 19:01:29 INFO - no previously-included directories found matching '.git*' 19:01:29 INFO - Successfully installed jsonschema functools32 19:01:29 INFO - Cleaning up... 19:01:29 INFO - Return code: 0 19:01:29 INFO - Running post-action listener: _resource_record_post_action 19:01:29 INFO - Running post-action listener: _start_resource_monitoring 19:01:29 INFO - Starting resource monitoring. 19:01:29 INFO - ##### 19:01:29 INFO - ##### Running install step. 19:01:29 INFO - ##### 19:01:29 INFO - Running pre-action listener: _resource_record_pre_action 19:01:29 INFO - Running main action method: install 19:01:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:01:29 INFO - Reading from file tmpfile_stdout 19:01:29 INFO - Detecting whether we're running mozinstall >=1.0... 19:01:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:01:29 INFO - Reading from file tmpfile_stdout 19:01:29 INFO - Output received: 19:01:29 INFO - Usage: mozinstall [options] installer 19:01:29 INFO - Options: 19:01:29 INFO - -h, --help show this help message and exit 19:01:29 INFO - -d DEST, --destination=DEST 19:01:29 INFO - Directory to install application into. [default: 19:01:29 INFO - "/builds/slave/test"] 19:01:29 INFO - --app=APP Application being installed. [default: firefox] 19:01:29 INFO - mkdir: /builds/slave/test/build/application 19:01:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:01:44 INFO - Reading from file tmpfile_stdout 19:01:44 INFO - Output received: 19:01:44 INFO - /builds/slave/test/build/application/firefox/firefox 19:01:44 INFO - Running post-action listener: _resource_record_post_action 19:01:44 INFO - ##### 19:01:44 INFO - ##### Running run-tests step. 19:01:44 INFO - ##### 19:01:44 INFO - Running pre-action listener: _resource_record_pre_action 19:01:44 INFO - Running main action method: run_tests 19:01:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:01:44 INFO - Python 2.7.3 19:01:44 INFO - Return code: 0 19:01:44 INFO - grabbing minidump binary from tooltool 19:01: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')]} 19:01:44 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2141220>, '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 0x20ad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ad740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:01:44 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 19:01:44 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 19:01:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:01:44 INFO - Return code: 0 19:01:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:01:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:01:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:01:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:01:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:01:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Ash-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost'] in /builds/slave/test/build 19:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Ash-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost 19:01:44 INFO - Using env: {'DISPLAY': ':0', 19:01:44 INFO - 'HOME': '/home/cltbld', 19:01:44 INFO - 'LANG': 'en_US.UTF-8', 19:01:44 INFO - 'LANGUAGE': 'en_US:en', 19:01:44 INFO - 'LOGNAME': 'cltbld', 19:01:44 INFO - 'MAIL': '/var/mail/cltbld', 19:01:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:01:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:44 INFO - 'MOZ_NO_REMOTE': '1', 19:01:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:44 INFO - 'NO_EM_RESTART': '1', 19:01:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:44 INFO - 'PWD': '/builds/slave/test', 19:01:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:01:44 INFO - 'SHELL': '/bin/bash', 19:01:44 INFO - 'SHLVL': '1', 19:01:44 INFO - 'TERM': 'linux', 19:01:44 INFO - 'TMOUT': '86400', 19:01:44 INFO - 'USER': 'cltbld', 19:01:44 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977', 19:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:44 INFO - '_': '/tools/buildbot/bin/python'} 19:01:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Ash-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost'] with output_timeout 3600 19:01:45 INFO - mozversion INFO | application_buildid: 20151202172925 19:01:45 INFO - mozversion INFO | application_changeset: 9e8976ff699465bf1c63ce7be351402bde10be18 19:01:45 INFO - mozversion INFO | application_display_name: Nightly 19:01:45 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:01:45 INFO - mozversion INFO | application_name: Firefox 19:01:45 INFO - mozversion INFO | application_remotingname: firefox 19:01:45 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/projects/ash 19:01:45 INFO - mozversion INFO | application_vendor: Mozilla 19:01:45 INFO - mozversion INFO | application_version: 45.0a1 19:01:45 INFO - mozversion INFO | platform_buildid: 20151202172925 19:01:45 INFO - mozversion INFO | platform_changeset: 9e8976ff699465bf1c63ce7be351402bde10be18 19:01:45 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/projects/ash 19:01:45 INFO - mozversion INFO | platform_version: 45.0a1 19:01:45 INFO - 2015-12-02 19:01:45,048 DEBUG : using testdate: 1449111705 19:01:45 INFO - 2015-12-02 19:01:45,048 DEBUG : actual date: 1449111705 19:01:45 INFO - 2015-12-02 19:01:45,056 INFO : starting webserver on 'localhost:40853' 19:01:45 INFO - 2015-12-02 19:01:45,057 INFO : Starting test suite talos-linux64-ix-026 19:01:45 INFO - 2015-12-02 19:01:45,058 INFO : Starting test dromaeo_css 19:01:45 INFO - 2015-12-02 19:01:45,058 DEBUG : operating with platform_type : linux_ 19:01:45 INFO - 2015-12-02 19:01:45,058 INFO : Initialising browser for dromaeo_css test... 19:01:45 INFO - 2015-12-02 19:01:45,071 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpem3LXX/profile http://localhost:40853/getInfo.html 19:01:49 INFO - 2015-12-02 19:01:49,077 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:01:49 INFO - 2015-12-02 19:01:49,078 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:01:49 INFO - 2015-12-02 19:01:49,078 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:01:49 INFO - 2015-12-02 19:01:49,078 DEBUG : BROWSER_OUTPUT: __metrics 19:01:49 INFO - 2015-12-02 19:01:49,220 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:01:50 INFO - 2015-12-02 19:01:50,792 INFO : Browser initialized. 19:01:50 INFO - 2015-12-02 19:01:50,792 INFO : Running cycle 1/1 for dromaeo_css test... 19:01:50 INFO - 2015-12-02 19:01:50,792 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpem3LXX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:02:02 INFO - 2015-12-02 19:02:02,651 DEBUG : BROWSER_OUTPUT: RSS: Main: 145842176 19:02:02 INFO - 2015-12-02 19:02:02,651 DEBUG : BROWSER_OUTPUT: 19:02:53 INFO - 2015-12-02 19:02:53,836 DEBUG : BROWSER_OUTPUT: 1449111773835 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] 19:05:05 INFO - 2015-12-02 19:05:05,767 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40853/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40853/tests/dromaeo/cssquery-ext.html) 19:05:06 INFO - 2015-12-02 19:05:06,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 242941952 19:05:06 INFO - 2015-12-02 19:05:06,824 DEBUG : BROWSER_OUTPUT: 19:08:09 INFO - 2015-12-02 19:08:09,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40853/tests/dromaeo/cssquery-ext.html (next: http://localhost:40853/tests/dromaeo/cssquery-jquery.html) 19:08:09 INFO - 2015-12-02 19:08:09,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 223182848 19:08:09 INFO - 2015-12-02 19:08:09,900 DEBUG : BROWSER_OUTPUT: 19:11:11 INFO - 2015-12-02 19:11:11,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40853/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40853/tests/dromaeo/cssquery-mootools.html) 19:11:12 INFO - 2015-12-02 19:11:12,515 DEBUG : BROWSER_OUTPUT: RSS: Main: 224833536 19:11:12 INFO - 2015-12-02 19:11:12,515 DEBUG : BROWSER_OUTPUT: 19:14:14 INFO - 2015-12-02 19:14:14,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40853/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40853/tests/dromaeo/cssquery-prototype.html) 19:14:15 INFO - 2015-12-02 19:14:15,108 DEBUG : BROWSER_OUTPUT: RSS: Main: 212389888 19:14:15 INFO - 2015-12-02 19:14:15,108 DEBUG : BROWSER_OUTPUT: 19:17:17 INFO - 2015-12-02 19:17:17,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40853/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40853/tests/dromaeo/cssquery-yui.html) 19:17:18 INFO - 2015-12-02 19:17:18,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 214417408 19:17:18 INFO - 2015-12-02 19:17:18,436 DEBUG : BROWSER_OUTPUT: 19:20:21 INFO - 2015-12-02 19:20:21,091 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40853/tests/dromaeo/cssquery-yui.html (next: http://localhost:40853/tests/dromaeo/cssquery-dojo.html) 19:20:21 INFO - 2015-12-02 19:20:21,354 DEBUG : BROWSER_OUTPUT: RSS: Main: 258547712 19:20:21 INFO - 2015-12-02 19:20:21,354 DEBUG : BROWSER_OUTPUT: 19:20:21 INFO - 2015-12-02 19:20:21,354 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:20:21 INFO - 2015-12-02 19:20:21,354 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:20:21 INFO - 2015-12-02 19:20:21,354 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:20:21 INFO - 2015-12-02 19:20:21,354 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:20:21 INFO - 2015-12-02 19:20:21,354 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2613.8693065346733;2729.249456399491;2737.7003317213535;2745.4234610731737;2746.3408781892354;4386.627136693385;4515.39042229299;4677.134730074934;4716.056788642272;4721.598664113554;4626.074785042988;4658.440987081555;4740.075685241371;4741.691790033646;4784.330193772866;4316.827326906936;4318.9784051079705;4324.84863029794;4337.501187363462;4353.978230108845;4164.437800896871;4362.760048197348;4379.868603941887;4425.31407631816;4435.135148645999;4207.978960105211;4238.512571054337;4249.065205654751;4329.112531930947;4330.588594083557;4370.300751879684;4373.343998400233;4374.387585737999;4376.256036473776;4412.801423935931;4351.369051487548;4354.891127721832;4363.040131171169;4400.405945197389;4402.581754733327;4448.221561226773;4520.163769702615;4596.057808149355;4603.148417542765;4619.74591397473;4965.528274813887;5026.623003274733;5094.694318340874;5108.157154069611;5110.259012443212;5074.13739664258;5095.872603184913;5113.181890897438;5117.257997590328;5164.819231326923;4453.643708503312;4549.363089167519;4549.385832912581;4735.2186889163595;4760.761961901926;5071.822486212965;5166.2767212589515;5167.6641018333685;5175.197844334134;5221.269022336875;4899.755012249373;4900.2894580286375;4903.068417000758;4908.435529914034;4932.186189278729;4818.7831547580445;4930.852074437701;4973.626977976666;4983.401991761012;4993.300937868701;4909.116359055404;4959.528844759742;5085.389753229636;5096.159133742965;5105.617078719111;4939.950600493949;4983.90032199354;4984.750762461862;4986.177280748709;5008.549230569266;4227.7463352198965;4260.510041345285;4263.4031235627035;4299.613034826881;4309.375140604658;3593.892183234455;3656.067702735785;3704.6480584344445;3715.5912849586525;3720.1071742781537;4346.695731298779;4356.368326592689;4373.562643735665;4391.5827996340295;4405.845795397146;5054.646174767731;5058.494150584912;5058.848234552969;5069.264956581349;5099.031184075014;4184.14225083857;4274.7435153890865;4282.8715138545895;4305.677074219446;4349.521552629209;4594.563516465931;4612.930806037912;4618.49196588375;4647.744374059392;4652.13935421948;4879.829205977845;4881.707097574157;4882.438519570223;4896.877578060577;4932.778024988812;4835.661503694849;4934.383202099738;4938.604911606991;4943.530364615356;5160.148575485153;4803.087413391444;4803.3995750531185;4811.9518804811505;4855.6115510758345;4857.149998750276;5004.049230646166;5006.449290578106;5011.724355160502;5012.373453318335;5025.7989680412375;4871.123197824284;4932.827351042696;4981.2030075187795;4990.525900039491;5125.79496820123;4990.975045124751;4991.3511243538105;4995.975020124876;5001.524855138756;5003.024410239968;4982.327385802871;4982.7259500727805;4991.80032798684;4995.975020125022;5029.773660185374;4491.910161796681;4665.650076244227;4668.719876807402;4744.288356746516;4929.580985616263;4967.155583550877;4977.950220497749;4985.875353116201;5008.373953255843;5021.748912554431;4854.247591623304;4854.514548545118;4867.902641947212;4868.561829435368;4902.92645610309 19:20:21 INFO - 2015-12-02 19:20:21,354 DEBUG : BROWSER_OUTPUT: |1;ext.html;544.7412479072441;554.4483239177019;566.6996491859314;573.1631817546381;575.7639367859178;26559.4688106238;27050.45899082017;36764.81617591915;37943;38086.428703569465;41018.38472422916;41083.38374924371;41124.794376028076;41145.79427102868;41475.792621036926;6883.621400822953;7847.293743563078;7997.840043199132;8033.317168040723;8056.033276006888;6927.411170050552;10131.189504839633;10397.844032339483;10409.947950260275;10416.166706663487;10035.648752293671;10140.49297535124;10147.797044059114;10149.39103653783;10154;7048.894266585954;7223.1332240131;10097.192224622013;10157.898421015843;10194.235432342604;9888.208943284591;10030.749231269203;10073.496325183785;10096.394216347042;10097.798044039078;37327.813360933294;37682.434763478566;37754.244915101546;37843.4323485148;37916.43125353122;2876.367199216169;3188.266698659298;3624.4925710400566;3672.7429079964145;3713.387291096966;28407.289817754514;28415;28644.570331445044;28666.426671466663;28709;3456.5333679953137;3462.497937799005;3468.5664291963503;3505.929881402383;3595.7662751921043;233425;234094;234251;234288;234465.99999999828;47542.76228618835;49338.259926101135;54068;54435.18347224795;54480;60508.69745651243;61968.38031619716;62218;62242.68878655578;62298.68850655809;13230.536931207362;13344.866551334557;13406.329683515785;13406.396712147976;13427.530036448677;9882.061204185591;9959.302848800515;9977.650782222587;9981.201503879673;10004.54979525923;17853.7321940171;18101.818981810276;18106.728399074025;18165.7275140873;18192.81807181911;6867.553609015398;7138.179109402381;7170.42636589082;7208.495405321577;7238.52949558277;787.4133770341133;877.806882485852;954.5847556313026;974.181687382602;1014.3457469932;26010.6098408524;26538.6019209712;26585.867070664524;26956.460870782474;27127.86436067807;862.3058437957379;933.6498812945146;999.7450650084182;1064.6060957445795;1067.8665166854144;14378.85621143796;14424;14591.854081459262;14751.704965900622;14780.113193208443;318706;320859;323337;323435;323552;42542.361864572056;43190.136197275875;49077.754611226715;49682.75158624184;54197;1228.705110773408;1252.7807633664254;1259.0871618076822;1263.5072321794507;1263.9810402843964;28219.858900705363;28805;29132.56301155442;29630.111096667133;29681;34680.30639387249;34785.65214347925;41901.58098419099;42514.149717006105;42565.36151957661;188831;189959;190770;190926;191037;27801.44397112087;27871.721282787723;28029.439411212068;28081;28162.577561336188;35513;35826.462603060456;36022.639773602976;36696.81651591725;36724.08189795277;33024.1743956403;33255;33926.49110263299;34462.58761886644;34701.82649086738;33704.49443258402;34380.828095860365;34518.30963380668;34595;34758.13104672403;38637.42043869288;38717.225655487295;39130.80434597809;39408;39695.40456893091;30239.848800755855;30989;31345.68654313519;31347.924769779784;31454.685453145175;24208.87895560511;24537.386565336008;24543.754562454862;24838.37904052341;24921.75078249194 19:20:21 INFO - 2015-12-02 19:20:21,354 DEBUG : BROWSER_OUTPUT: |2;jquery.html;335.82369256140515;339.94560870260756;341.2969283276452;342.59744799860187;343.97936123832574;12257.570985015525;12864.485420583189;15423.151726655044;15454.922725386372;16041.518754437371;12731.681707957283;14622.195779232137;14703.411863525473;15072.246387680627;15079.773803392958;4871.585915197213;4940.555350018498;5070.036693028332;5094.821681241157;5098.515641014116;3536.1513236823107;3645.143391303042;5012.899742005157;5064.696118232918;5068.5691716204165;3625.329314076891;3625.6011838697723;3628.129248980252;3629.2922880038404;5364.088105022136;5422.728863556846;5539.584531160159;5585.888282234373;5591.41290164533;5618.073017952033;4872.3909511311085;4948.455669876311;4951.232558953368;4960.1567733485035;4960.975195124001;18910.338138165098;18996.810031899782;19005.524861878424;19042.714359284622;19677.508062298413;1713.5544758362792;1801.7477553142571;1812.0848971269556;1885.9905700471547;1900.4203717866046;12636.68408289791;12736.04479664029;12750.681232969157;12894.742105157844;13033.348332583428;1754.7894252689632;1777.7866656001233;1786.6873297172942;1800.5858652509864;1803.071418219618;52407.73796131033;55098.44901551013;55470.9999999996;55728.44271557273;56228.15657765096;9396.95301523488;9475.336726429085;9522.428654280766;9647.372920760128;9680.128788409076;12267.509299627915;12290.938545307396;12298.262104273772;12317;12335.136540442263;6699.095622091053;6754.088198093293;6784.966075169691;6850.6574671266235;6936.271691472423;6214.751409943642;6232.906506402408;6259.374062593704;6274.874502509924;6288.213973253343;5697.0599851024945;5769.94230057694;5774.105013722879;5780.653160810365;5811.070228763378;1528.5414375687249;1594.194931559555;1635.9509214723578;1666.258514960855;1701.948941531756;808.7290757596271;880.903100658927;886.1625763653415;939.3659279985982;972.8978457262027;16162.191890405433;16278.51164465068;16296.185190740416;16603.41888033913;16662.750058749127;808.4744915804774;873.921347078766;893.4192774696369;902.2601466797295;913.2191975860676;8246.958765206136;8961.23829474489;9004.054574269738;9062.91245050598;9084.227840633488;503111;509812;510485;510626;517862;69759;71315.28684713191;74307;74311.25688743043;74392;1053.2837670384213;1064.1327318235612;1105.2649987758211;1132.6149109302712;1137.0789660375124;13233.933830331172;13899.235542045284;14167.291635418394;14397.568072957829;14432.85567144357;31008;31095.844520777253;31524.527132093495;32595;32921;37690.623093769806;39182;39447.605523944396;40671.38992915049;45665.543344566126;8840.160184782435;9025.323100767337;9083.954580227057;9118.863217051618;9233.399829011092;10719.410432425979;10794.352338859379;10797.838032429363;10875.564977400816;16339.183040847673;13388.19670819754;13541.864581354454;13640.727185456037;13683.384247708678;14194.92902535522;13169.144005639602;13212.273324967218;13431.664208394868;13688.726225475633;13892.791608125684;10474;12324.445399956845;13493.662658433617;13872.930635346758;14414.567562973127;9008.954955225181;9114.817703646022;9196;9198.356115071882;9266.814663706822;9898.604055837974;10454;13816.861831381959;14046.227457489937;14176.362063707364 19:20:21 INFO - 2015-12-02 19:20:21,356 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1357.6130802721227;1559.2359743725572;1611.1541440743608;1619.101398723708;1638.6968410844001;5700.515456186224;6674.466042716583;6847.828804279896;6852.109225800646;6862.382385585309;6803.489738269637;6929.925861491464;6963.547369420997;6975.128108986377;7000.684969176386;1732.7141021731463;1766.6731654643868;2047.8361731061555;2053.045333919727;2095.3713885834263;2101.695254188142;2110.7783682713325;2116.0689296709397;2118.205672872673;2118.692789545515;2033.2375359240284;2033.2578608807826;2076.7923207679187;2080.3758872338312;2083.8437117216267;2047.2118234479683;2054.7431571053617;2077.937661870139;2079.261862038977;2092.3199960012903;2071.6892466130053;2076.4705000224844;2081.906314215849;2087.84341174411;2091.633964056299;6299.622022678654;6361.01404282337;6362.522810789209;6365.331640177761;6381.329960354189;4041.73728707636;4099.1801639672185;4141.730787498803;4145.295299799011;4149.91700165995;2273.89767460463;2664.507066192741;2757.7931655125944;2769.127724766692;2780.986095069532;766.295008592091;813.4184058398215;874.4753148111146;905.6830109461702;922.7324076017946;8943.731688049369;9001.684941027033;9026.86459703105;9027.503487308195;9056.773580660536;3884.2425726983533;3924.862629807943;3960.544537378181;3984.86052988144;3997.560268370477;7860.410469214832;7865.646045927947;7878.290953814184;7898.170692077249;7901.960490197627;4128.752274863517;4130.401091841726;4131.215069136854;4138.875833724993;4140.68944829139;3779.149691319486;3779.3008293465796;3781.8676346327748;3782.394816829294;3792.7534710243744;2802.103326935361;2847.245479947774;3015.5627434021944;3061.127578640077;3237.4658181399805;1090.1006669497538;1094.1684319916762;1098.3519723363254;1107.5237647811357;1114.2590177532013;852.7015544559355;853.0616322045701;856.6316483911853;884.7832281091174;997.670768646345;6315.747370105236;6347.96826015867;6371.49028077762;6380.457661098859;6381.266154392211;996.8953259907605;1002.7994401119805;1024.2676486312323;1029.3360782295379;1034.2811745836723;4945.109880221523;4953.826616068421;4985.102681517362;4997.175466048134;5001.474845141281;7769.300762931363;7955.323797477164;8034.397420193509;8040.597970101471;8110.432269741062;7940.364770818321;8036.316913062456;8046;8060.717874874468;8132.5933703314595;6240.063990401385;6350.142730731384;6365.713542890581;6373.553851230369;6384.3934826191435;5840.649561026352;6038.184845045863;6047.909281360695;6055;6062.393760623902;7088;7176.712931482891;7193.928060719326;7251.456140789567;7262.055932728923;7225.349718525358;7345.192028876926;7381.298776616428;7424.220456852169;7429.219931907072;5672.319321681424;5747.798827041033;5757.280339957505;5775.537956963349;5777.133429985536;5435.510804027656;5577.553795696415;5833.649981001154;6245.406686364788;6324.588901721373;5879.470847623735;5907.645541267538;6095;6125.632462052291;6156.630602163885;5649.067903795828;5654.236678048575;5709.800156994652;5917.201177840936;6057.969710151421;6087.9391206087375;6097.817065488042;6113.908291375544;6142.969285153546;6153.661548614869;5436.6194366393975;5568.9443105568425;5569.0254205513065;5590.357108932362;5593.496585307342;5674.375818660027;5731.168980497888;5737.770489180386;5738.913916291175;5758.078707406795 19:20:21 INFO - 2015-12-02 19:20:21,357 DEBUG : BROWSER_OUTPUT: |4;prototype.html;312.5811412706973;313.02024662805417;321.3572854291417;325.36066629073866;328.11736429005987;5208;5237.84286471406;5346.27825243592;5405.18922161676;5425.159100339449;5160.406553246377;5301.1783173608055;5320.733963301839;5327.200919862023;5330.773921997943;3962.385830196324;4052.128792309653;4178.832846686137;4187.602177793105;4196.62230399264;4049.1496785675045;4124.876253712393;4137.979310103446;4142.047329114305;4145.481814773153;4085.2850751118435;4085.46888904442;4124.443200167984;4126.525449573308;4141.151064031867;4127.442795222667;4134.317837556815;4141.109661422778;4143.647789937859;4143.792810359485;3615.168511242429;3619.0047736872307;3619.2580520993133;3620.9275814483826;3629.5281613390353;4953.504649535053;5064.290999260106;5074.847754567369;5075.314832497639;5092.083424983502;4735.12400205963;4736.123817093849;4741.9288710669025;4754.120487709784;4755.405574303212;5334.413214546396;5579.549317177522;5585.748641311151;5592.944070559283;5600.971995140039;3797.4493698413853;3842.8270727817317;3968.523777146732;3972.8808135755685;3975.1453437510786;5819.185314056035;5878.912401205748;5936.198613187207;5942.673152976585;5943.970280148572;4068.6338229559483;4071.531773845986;4073.51117865858;4076.8573099941955;4077.1641813428178;4040.0303927057294;4126.339785634284;4128.4632997710705;4132.462779838602;4132.690048246333;4734.905301894012;4743.810247590127;4745.1695953208055;4746.027064451848;4753.215719406328;5655;5655.462731040545;5658.236138121383;5665.915011274834;5666.376698563155;1443.235085404716;1460.4377314733692;1469.390203065737;1469.419579266184;1469.9853001470062;987.2990176974286;989.7575094101991;992.6575331510618;1006.8036732837027;1013.4223492609142;4970.90058198834;4976.776045077981;4981.551660350586;4982;4989.625778066587;5860.882782344414;5862.208601838783;5867.794627188028;5868.559858010666;5869.735861886225;4953.950460495349;4970.030843985461;4970.65205435616;4970.90058198834;4978.10394129053;3090.474619314722;3138.5292206169256;3164.7626428017993;3167.714905658456;3169.6196456424914;5538.667679939216;5543.916841247385;5547.750351234205;5550.611457198038;5551.278333816659;6000.609960352563;6009.849753756191;6014.037753959433;6017.819465416044;6021.6989150542295;5398.08232600451;5508.586855985817;5512.0905050667;5522.420145884785;5531.474509921551;5792.4497172768515;5825.097109947965;5827.271591051119;5830.47525722687;5833.708314584339;5508.862278443071;5630.95827271956;5679.403662615531;5780.913286300624;5788.044972579645;5554.1391084381985;5563.582731295088;5566.91649625264;5569.582281328835;5578.944210557843;4065.0853557949226;4065.4918135233097;4065.796710164421;4069.308217602955;4072.6131017553284;5689.431056894277;5886.411358864079;5889.911651325319;5896.882062358814;5916.615419997686;5652.773889044557;5682.6306290091015;5683.232763576864;5686.886262274648;5696.458836410535;5647.632903861236;5682.715864206856;5686.09022556389;5690.914636280542;5694.487496125203;5359.651622644516;5580.2466666999435;5580.497755202051;5581.10702287632;5581.5255703265675;5714.9142762857755;5720;5722.62802917809;5726.112452569859;5731.369549349485;5580.135079062752;5585;5587.469190426903;5588.608797384307;5589.385167631639 19:20:21 INFO - 2015-12-02 19:20:21,357 DEBUG : BROWSER_OUTPUT: |5;yui.html;601.9367966363529;659.9868002639947;660.9041688955099;697.9391325185716;716.1549371741346;11327;11405.600803971862;11411.54353825847;11416.42917854106;11424.485898134582;11323;11372.090232781378;11726.648200553976;11758.470868810902;11821;579.5942840011987;580.7967211475992;755.2070326157526;771.0747103475824;771.1555846348268;764.3235736373294;773.2383602151876;777.059757693192;783.3967844759532;783.6199443270039;793.6666600028002;805.3718099882101;807.5477732469807;807.5962018990505;807.8505476486839;607.331934871642;627.4196368359272;799.7560743973086;800.1438460846896;814.0638265994095;601.5097695378253;602.3374288282897;602.7016626769777;602.7528713227556;602.7860109661095;11123.55393798801;11129.666110016713;11229.3262404256;11243.887561124448;11249.718757031058;11377.431128443544;11423.828642570368;11592.826107608393;11639.534418623245;11711.297322160612;9087.545622718837;9111.362204645677;9151.954240228757;9198.402103863227;9198.586063627154;3229.289556297611;3241.7892836965757;3282.917927051819;3302.9834850825832;3327.7504187185814;40145.197096058204;40320.596794031975;40737.18525629501;40800.18399632021;40823.7958810207;8722.65109395617;8915.73252802417;9279.536321945632;9323.067693230623;9422.34043616954;16102.919485402497;16215.83784162167;16227.918860405622;16242.67514649724;16317.918410407872;6116.724747386378;6207;6307.24313082433;6396.1045453636525;6414.069959855888;3479.7912125272564;3633.6366363363454;3705.5738590061947;3721.423179407196;3722.3671975763646;2644.656194694677;2681.356474446158;2682.1417146513318;2683.0475181310744;2684.2752456836934;474.44016061048296;481.2949029671548;482.1947347928967;484.8012314950924;488.1506179248154;389.7856179101483;395.8317714971126;416.2943810241611;418.56260208082625;468.54082998661505;6678.666066696645;6774.187097548326;6857.657117144123;6972.895406568906;7045;376.05047255679625;405.062280819901;434.3311300597045;441.67265072448237;562.2493970549363;3234.8706051758136;3423.726101911891;3465.5494785678206;3530.452779819132;3530.9578715068865;49641.255381169314;50414;50449;50691.74654126706;50789.49210507922;44472.555274446844;44567.554324456985;44669.77665111719;44816.77591612086;45038;39214.80392598019;39734;40761.79619101885;41216;41455.7927210362;7290.526115802456;7498.887516687363;7609.124950630527;7817.648205830637;8088.433809633269;29854.850725746233;30778.076657700305;31005.379892402478;31313;32117.6788232124;38997.41503877387;39095.04524773693;39802.80098599489;40198;40792.59207407888;9214.631414743335;9344.906550934404;9612.423254604746;9805.21558275322;9843.557039933363;10811.189160812813;10837.566497340018;10874.29317094418;10925.781484370109;10943.835842462211;9875.20998320147;10054.29619926598;10251.436171010666;10292.176625870063;10559.736006599896;10088.54601542947;10202.744931376776;10315.27793054479;10353.792924141626;10512.316699414514;9046.185843274137;9458.148766611039;10257.384556926609;10339.948300258451;10617.256792024484;8365.24712775853;8544;8554.657813687383;8579.65681372763;8680.479171249744;8445.324374049938;8537.542295370386;8665.566721663765;8668.523231222343;8761.342899282707 19:20:21 INFO - 2015-12-02 19:20:21,357 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:20:21 INFO - 2015-12-02 19:20:21,357 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:20:21 INFO - 2015-12-02 19:20:21,357 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,864 19:20:21 INFO - 2015-12-02 19:20:21,357 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:20:21 INFO - 2015-12-02 19:20:21,357 DEBUG : BROWSER_OUTPUT: __startTimestamp1449112821351__endTimestamp 19:20:21 INFO - 2015-12-02 19:20:21,358 DEBUG : BROWSER_OUTPUT: 19:20:21 INFO - 2015-12-02 19:20:21,358 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:20:21 INFO - 2015-12-02 19:20:21,358 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:20:21 INFO - 2015-12-02 19:20:21,358 DEBUG : BROWSER_OUTPUT: 19:20:21 INFO - 2015-12-02 19:20:21,358 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4655.44 Median:4818.78 stddev:485.32 (10.1%) stddev-sans-first:459.62 19:20:21 INFO - 2015-12-02 19:20:21,359 DEBUG : BROWSER_OUTPUT: Values: 2613.9 2729.2 2737.7 2745.4 2746.3 4386.6 4515.4 4677.1 4716.1 4721.6 4626.1 4658.4 4740.1 4741.7 4784.3 4316.8 4319.0 4324.8 4337.5 4354.0 4164.4 4362.8 4379.9 4425.3 4435.1 4208.0 4238.5 4249.1 4329.1 4330.6 4370.3 4373.3 4374.4 4376.3 4412.8 4351.4 4354.9 4363.0 4400.4 4402.6 4448.2 4520.2 4596.1 4603.1 4619.7 4965.5 5026.6 5094.7 5108.2 5110.3 5074.1 5095.9 5113.2 5117.3 5164.8 4453.6 4549.4 4549.4 4735.2 4760.8 5071.8 5166.3 5167.7 5175.2 5221.3 4899.8 4900.3 4903.1 4908.4 4932.2 4818.8 4930.9 4973.6 4983.4 4993.3 4909.1 4959.5 5085.4 5096.2 5105.6 4940.0 4983.9 4984.8 4986.2 5008.5 4227.7 4260.5 4263.4 4299.6 4309.4 3593.9 3656.1 3704.6 3715.6 3720.1 4346.7 4356.4 4373.6 4391.6 4405.8 5054.6 5058.5 5058.8 5069.3 5099.0 4184.1 4274.7 4282.9 4305.7 4349.5 4594.6 4612.9 4618.5 4647.7 4652.1 4879.8 4881.7 4882.4 4896.9 4932.8 4835.7 4934.4 4938.6 4943.5 5160.1 4803.1 4803.4 4812.0 4855.6 4857.1 5004.0 5006.4 5011.7 5012.4 5025.8 4871.1 4932.8 4981.2 4990.5 5125.8 4991.0 4991.4 4996.0 5001.5 5003.0 4982.3 4982.7 4991.8 4996.0 5029.8 4491.9 4665.7 4668.7 4744.3 4929.6 4967.2 4978.0 4985.9 5008.4 5021.7 4854.2 4854.5 4867.9 4868.6 4902.9 19:20:21 INFO - 2015-12-02 19:20:21,359 DEBUG : BROWSER_OUTPUT: 19:20:21 INFO - 2015-12-02 19:20:21,359 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41422.02 Median:33479.75 stddev:66602.30 (198.9%) stddev-sans-first:66718.42 19:20:21 INFO - 2015-12-02 19:20:21,359 DEBUG : BROWSER_OUTPUT: Values: 544.7 554.4 566.7 573.2 575.8 26559.5 27050.5 36764.8 37943.0 38086.4 41018.4 41083.4 41124.8 41145.8 41475.8 6883.6 7847.3 7997.8 8033.3 8056.0 6927.4 10131.2 10397.8 10409.9 10416.2 10035.6 10140.5 10147.8 10149.4 10154.0 7048.9 7223.1 10097.2 10157.9 10194.2 9888.2 10030.7 10073.5 10096.4 10097.8 37327.8 37682.4 37754.2 37843.4 37916.4 2876.4 3188.3 3624.5 3672.7 3713.4 28407.3 28415.0 28644.6 28666.4 28709.0 3456.5 3462.5 3468.6 3505.9 3595.8 233425.0 234094.0 234251.0 234288.0 234466.0 47542.8 49338.3 54068.0 54435.2 54480.0 60508.7 61968.4 62218.0 62242.7 62298.7 13230.5 13344.9 13406.3 13406.4 13427.5 9882.1 9959.3 9977.7 9981.2 10004.5 17853.7 18101.8 18106.7 18165.7 18192.8 6867.6 7138.2 7170.4 7208.5 7238.5 787.4 877.8 954.6 974.2 1014.3 26010.6 26538.6 26585.9 26956.5 27127.9 862.3 933.6 999.7 1064.6 1067.9 14378.9 14424.0 14591.9 14751.7 14780.1 318706.0 320859.0 323337.0 323435.0 323552.0 42542.4 43190.1 49077.8 49682.8 54197.0 1228.7 1252.8 1259.1 1263.5 1264.0 28219.9 28805.0 29132.6 29630.1 29681.0 34680.3 34785.7 41901.6 42514.1 42565.4 188831.0 189959.0 190770.0 190926.0 191037.0 27801.4 27871.7 28029.4 28081.0 28162.6 35513.0 35826.5 36022.6 36696.8 36724.1 33024.2 33255.0 33926.5 34462.6 34701.8 33704.5 34380.8 34518.3 34595.0 34758.1 38637.4 38717.2 39130.8 39408.0 39695.4 30239.8 30989.0 31345.7 31347.9 31454.7 24208.9 24537.4 24543.8 24838.4 24921.8 19:20:21 INFO - 2015-12-02 19:20:21,359 DEBUG : BROWSER_OUTPUT: 19:20:21 INFO - 2015-12-02 19:20:21,359 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26843.87 Median:3625.47 stddev:83324.27 (2298.3%) stddev-sans-first:83534.24 19:20:21 INFO - 2015-12-02 19:20:21,360 DEBUG : BROWSER_OUTPUT: Values: 335.8 339.9 341.3 342.6 344.0 12257.6 12864.5 15423.2 15454.9 16041.5 12731.7 14622.2 14703.4 15072.2 15079.8 4871.6 4940.6 5070.0 5094.8 5098.5 3536.2 3645.1 5012.9 5064.7 5068.6 3625.3 3625.6 3628.1 3629.3 5364.1 5422.7 5539.6 5585.9 5591.4 5618.1 4872.4 4948.5 4951.2 4960.2 4961.0 18910.3 18996.8 19005.5 19042.7 19677.5 1713.6 1801.7 1812.1 1886.0 1900.4 12636.7 12736.0 12750.7 12894.7 13033.3 1754.8 1777.8 1786.7 1800.6 1803.1 52407.7 55098.4 55471.0 55728.4 56228.2 9397.0 9475.3 9522.4 9647.4 9680.1 12267.5 12290.9 12298.3 12317.0 12335.1 6699.1 6754.1 6785.0 6850.7 6936.3 6214.8 6232.9 6259.4 6274.9 6288.2 5697.1 5769.9 5774.1 5780.7 5811.1 1528.5 1594.2 1636.0 1666.3 1701.9 808.7 880.9 886.2 939.4 972.9 16162.2 16278.5 16296.2 16603.4 16662.8 808.5 873.9 893.4 902.3 913.2 8247.0 8961.2 9004.1 9062.9 9084.2 503111.0 509812.0 510485.0 510626.0 517862.0 69759.0 71315.3 74307.0 74311.3 74392.0 1053.3 1064.1 1105.3 1132.6 1137.1 13233.9 13899.2 14167.3 14397.6 14432.9 31008.0 31095.8 31524.5 32595.0 32921.0 37690.6 39182.0 39447.6 40671.4 45665.5 8840.2 9025.3 9084.0 9118.9 9233.4 10719.4 10794.4 10797.8 10875.6 16339.2 13388.2 13541.9 13640.7 13683.4 14194.9 13169.1 13212.3 13431.7 13688.7 13892.8 10474.0 12324.4 13493.7 13872.9 14414.6 9009.0 9114.8 9196.0 9198.4 9266.8 9898.6 10454.0 13816.9 14046.2 14176.4 19:20:21 INFO - 2015-12-02 19:20:21,360 DEBUG : BROWSER_OUTPUT: 19:20:21 INFO - 2015-12-02 19:20:21,360 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4700.20 Median:5752.54 stddev:2376.60 (41.3%) stddev-sans-first:2369.99 19:20:21 INFO - 2015-12-02 19:20:21,361 DEBUG : BROWSER_OUTPUT: Values: 1357.6 1559.2 1611.2 1619.1 1638.7 5700.5 6674.5 6847.8 6852.1 6862.4 6803.5 6929.9 6963.5 6975.1 7000.7 1732.7 1766.7 2047.8 2053.0 2095.4 2101.7 2110.8 2116.1 2118.2 2118.7 2033.2 2033.3 2076.8 2080.4 2083.8 2047.2 2054.7 2077.9 2079.3 2092.3 2071.7 2076.5 2081.9 2087.8 2091.6 6299.6 6361.0 6362.5 6365.3 6381.3 4041.7 4099.2 4141.7 4145.3 4149.9 2273.9 2664.5 2757.8 2769.1 2781.0 766.3 813.4 874.5 905.7 922.7 8943.7 9001.7 9026.9 9027.5 9056.8 3884.2 3924.9 3960.5 3984.9 3997.6 7860.4 7865.6 7878.3 7898.2 7902.0 4128.8 4130.4 4131.2 4138.9 4140.7 3779.1 3779.3 3781.9 3782.4 3792.8 2802.1 2847.2 3015.6 3061.1 3237.5 1090.1 1094.2 1098.4 1107.5 1114.3 852.7 853.1 856.6 884.8 997.7 6315.7 6348.0 6371.5 6380.5 6381.3 996.9 1002.8 1024.3 1029.3 1034.3 4945.1 4953.8 4985.1 4997.2 5001.5 7769.3 7955.3 8034.4 8040.6 8110.4 7940.4 8036.3 8046.0 8060.7 8132.6 6240.1 6350.1 6365.7 6373.6 6384.4 5840.6 6038.2 6047.9 6055.0 6062.4 7088.0 7176.7 7193.9 7251.5 7262.1 7225.3 7345.2 7381.3 7424.2 7429.2 5672.3 5747.8 5757.3 5775.5 5777.1 5435.5 5577.6 5833.6 6245.4 6324.6 5879.5 5907.6 6095.0 6125.6 6156.6 5649.1 5654.2 5709.8 5917.2 6058.0 6087.9 6097.8 6113.9 6143.0 6153.7 5436.6 5568.9 5569.0 5590.4 5593.5 5674.4 5731.2 5737.8 5738.9 5758.1 19:20:21 INFO - 2015-12-02 19:20:21,361 DEBUG : BROWSER_OUTPUT: 19:20:21 INFO - 2015-12-02 19:20:21,361 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4679.22 Median:5310.96 stddev:1371.93 (25.8%) stddev-sans-first:1336.06 19:20:21 INFO - 2015-12-02 19:20:21,361 DEBUG : BROWSER_OUTPUT: Values: 312.6 313.0 321.4 325.4 328.1 5208.0 5237.8 5346.3 5405.2 5425.2 5160.4 5301.2 5320.7 5327.2 5330.8 3962.4 4052.1 4178.8 4187.6 4196.6 4049.1 4124.9 4138.0 4142.0 4145.5 4085.3 4085.5 4124.4 4126.5 4141.2 4127.4 4134.3 4141.1 4143.6 4143.8 3615.2 3619.0 3619.3 3620.9 3629.5 4953.5 5064.3 5074.8 5075.3 5092.1 4735.1 4736.1 4741.9 4754.1 4755.4 5334.4 5579.5 5585.7 5592.9 5601.0 3797.4 3842.8 3968.5 3972.9 3975.1 5819.2 5878.9 5936.2 5942.7 5944.0 4068.6 4071.5 4073.5 4076.9 4077.2 4040.0 4126.3 4128.5 4132.5 4132.7 4734.9 4743.8 4745.2 4746.0 4753.2 5655.0 5655.5 5658.2 5665.9 5666.4 1443.2 1460.4 1469.4 1469.4 1470.0 987.3 989.8 992.7 1006.8 1013.4 4970.9 4976.8 4981.6 4982.0 4989.6 5860.9 5862.2 5867.8 5868.6 5869.7 4954.0 4970.0 4970.7 4970.9 4978.1 3090.5 3138.5 3164.8 3167.7 3169.6 5538.7 5543.9 5547.8 5550.6 5551.3 6000.6 6009.8 6014.0 6017.8 6021.7 5398.1 5508.6 5512.1 5522.4 5531.5 5792.4 5825.1 5827.3 5830.5 5833.7 5508.9 5631.0 5679.4 5780.9 5788.0 5554.1 5563.6 5566.9 5569.6 5578.9 4065.1 4065.5 4065.8 4069.3 4072.6 5689.4 5886.4 5889.9 5896.9 5916.6 5652.8 5682.6 5683.2 5686.9 5696.5 5647.6 5682.7 5686.1 5690.9 5694.5 5359.7 5580.2 5580.5 5581.1 5581.5 5714.9 5720.0 5722.6 5726.1 5731.4 5580.1 5585.0 5587.5 5588.6 5589.4 19:20:21 INFO - 2015-12-02 19:20:21,361 DEBUG : BROWSER_OUTPUT: 19:20:21 INFO - 2015-12-02 19:20:21,361 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12075.23 Median:44520.05 stddev:13915.47 (31.3%) stddev-sans-first:13927.83 19:20:21 INFO - 2015-12-02 19:20:21,361 DEBUG : BROWSER_OUTPUT: Values: 601.9 660.0 660.9 697.9 716.2 11327.0 11405.6 11411.5 11416.4 11424.5 11323.0 11372.1 11726.6 11758.5 11821.0 579.6 580.8 755.2 771.1 771.2 764.3 773.2 777.1 783.4 783.6 793.7 805.4 807.5 807.6 807.9 607.3 627.4 799.8 800.1 814.1 601.5 602.3 602.7 602.8 602.8 11123.6 11129.7 11229.3 11243.9 11249.7 11377.4 11423.8 11592.8 11639.5 11711.3 9087.5 9111.4 9152.0 9198.4 9198.6 3229.3 3241.8 3282.9 3303.0 3327.8 40145.2 40320.6 40737.2 40800.2 40823.8 8722.7 8915.7 9279.5 9323.1 9422.3 16102.9 16215.8 16227.9 16242.7 16317.9 6116.7 6207.0 6307.2 6396.1 6414.1 3479.8 3633.6 3705.6 3721.4 3722.4 2644.7 2681.4 2682.1 2683.0 2684.3 474.4 481.3 482.2 484.8 488.2 389.8 395.8 416.3 418.6 468.5 6678.7 6774.2 6857.7 6972.9 7045.0 376.1 405.1 434.3 441.7 562.2 3234.9 3423.7 3465.5 3530.5 3531.0 49641.3 50414.0 50449.0 50691.7 50789.5 44472.6 44567.6 44669.8 44816.8 45038.0 39214.8 39734.0 40761.8 41216.0 41455.8 7290.5 7498.9 7609.1 7817.6 8088.4 29854.9 30778.1 31005.4 31313.0 32117.7 38997.4 39095.0 39802.8 40198.0 40792.6 9214.6 9344.9 9612.4 9805.2 9843.6 10811.2 10837.6 10874.3 10925.8 10943.8 9875.2 10054.3 10251.4 10292.2 10559.7 10088.5 10202.7 10315.3 10353.8 10512.3 9046.2 9458.1 10257.4 10339.9 10617.3 8365.2 8544.0 8554.7 8579.7 8680.5 8445.3 8537.5 8665.6 8668.5 8761.3 19:20:21 INFO - 2015-12-02 19:20:21,362 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:20:21 INFO - 2015-12-02 19:20:21,363 DEBUG : BROWSER_OUTPUT: 19:20:22 INFO - 2015-12-02 19:20:22,105 INFO : Browser exited with error code: 0 19:20:22 INFO - 2015-12-02 19:20:22,121 INFO : Completed test dromaeo_css (00:18:37) 19:20:22 INFO - 2015-12-02 19:20:22,121 INFO : Starting test kraken 19:20:22 INFO - 2015-12-02 19:20:22,121 DEBUG : operating with platform_type : linux_ 19:20:22 INFO - 2015-12-02 19:20:22,121 INFO : Initialising browser for kraken test... 19:20:22 INFO - 2015-12-02 19:20:22,127 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpng2HDv/profile http://localhost:40853/getInfo.html 19:20:26 INFO - 2015-12-02 19:20:26,162 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:20:26 INFO - 2015-12-02 19:20:26,162 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:20:26 INFO - 2015-12-02 19:20:26,162 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:20:26 INFO - 2015-12-02 19:20:26,162 DEBUG : BROWSER_OUTPUT: __metrics 19:20:26 INFO - 2015-12-02 19:20:26,267 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:20:27 INFO - 2015-12-02 19:20:27,597 INFO : Browser initialized. 19:20:27 INFO - 2015-12-02 19:20:27,598 INFO : Running cycle 1/1 for kraken test... 19:20:27 INFO - 2015-12-02 19:20:27,598 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpng2HDv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:20:39 INFO - 2015-12-02 19:20:39,525 DEBUG : BROWSER_OUTPUT: RSS: Main: 145858560 19:20:39 INFO - 2015-12-02 19:20:39,525 DEBUG : BROWSER_OUTPUT: 19:20:42 INFO - 2015-12-02 19:20:42,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40853/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40853/tests/kraken/driver.html?testName=audio-beat-detection) 19:20:42 INFO - 2015-12-02 19:20:42,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 183578624 19:20:42 INFO - 2015-12-02 19:20:42,687 DEBUG : BROWSER_OUTPUT: 19:20:45 INFO - 2015-12-02 19:20:45,351 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40853/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40853/tests/kraken/driver.html?testName=audio-dft) 19:20:45 INFO - 2015-12-02 19:20:45,924 DEBUG : BROWSER_OUTPUT: RSS: Main: 173518848 19:20:45 INFO - 2015-12-02 19:20:45,924 DEBUG : BROWSER_OUTPUT: 19:20:48 INFO - 2015-12-02 19:20:48,882 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40853/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40853/tests/kraken/driver.html?testName=audio-fft) 19:20:49 INFO - 2015-12-02 19:20:49,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 157925376 19:20:49 INFO - 2015-12-02 19:20:49,455 DEBUG : BROWSER_OUTPUT: 19:20:51 INFO - 2015-12-02 19:20:51,477 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40853/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40853/tests/kraken/driver.html?testName=audio-oscillator) 19:20:52 INFO - 2015-12-02 19:20:52,058 DEBUG : BROWSER_OUTPUT: RSS: Main: 160169984 19:20:52 INFO - 2015-12-02 19:20:52,058 DEBUG : BROWSER_OUTPUT: 19:20:54 INFO - 2015-12-02 19:20:54,273 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40853/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40853/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:20:54 INFO - 2015-12-02 19:20:54,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 160673792 19:20:54 INFO - 2015-12-02 19:20:54,839 DEBUG : BROWSER_OUTPUT: 19:20:57 INFO - 2015-12-02 19:20:57,844 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40853/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40853/tests/kraken/driver.html?testName=imaging-darkroom) 19:20:58 INFO - 2015-12-02 19:20:58,430 DEBUG : BROWSER_OUTPUT: RSS: Main: 161505280 19:20:58 INFO - 2015-12-02 19:20:58,430 DEBUG : BROWSER_OUTPUT: 19:21:01 INFO - 2015-12-02 19:21:01,892 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40853/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40853/tests/kraken/driver.html?testName=imaging-desaturate) 19:21:02 INFO - 2015-12-02 19:21:02,465 DEBUG : BROWSER_OUTPUT: RSS: Main: 163381248 19:21:02 INFO - 2015-12-02 19:21:02,465 DEBUG : BROWSER_OUTPUT: 19:21:05 INFO - 2015-12-02 19:21:05,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40853/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40853/tests/kraken/driver.html?testName=json-parse-financial) 19:21:05 INFO - 2015-12-02 19:21:05,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 161783808 19:21:05 INFO - 2015-12-02 19:21:05,871 DEBUG : BROWSER_OUTPUT: 19:21:07 INFO - 2015-12-02 19:21:07,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40853/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40853/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:21:08 INFO - 2015-12-02 19:21:08,202 DEBUG : BROWSER_OUTPUT: RSS: Main: 175697920 19:21:08 INFO - 2015-12-02 19:21:08,202 DEBUG : BROWSER_OUTPUT: 19:21:10 INFO - 2015-12-02 19:21:10,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40853/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40853/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:21:10 INFO - 2015-12-02 19:21:10,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 175984640 19:21:10 INFO - 2015-12-02 19:21:10,678 DEBUG : BROWSER_OUTPUT: 19:21:12 INFO - 2015-12-02 19:21:12,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40853/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40853/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:21:13 INFO - 2015-12-02 19:21:13,362 DEBUG : BROWSER_OUTPUT: RSS: Main: 178954240 19:21:13 INFO - 2015-12-02 19:21:13,362 DEBUG : BROWSER_OUTPUT: 19:21:15 INFO - 2015-12-02 19:21:15,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40853/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40853/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:21:16 INFO - 2015-12-02 19:21:16,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 187441152 19:21:16 INFO - 2015-12-02 19:21:16,492 DEBUG : BROWSER_OUTPUT: 19:21:19 INFO - 2015-12-02 19:21:19,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40853/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40853/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:21:19 INFO - 2015-12-02 19:21:19,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 184791040 19:21:19 INFO - 2015-12-02 19:21:19,649 DEBUG : BROWSER_OUTPUT: 19:21:21 INFO - 2015-12-02 19:21:21,423 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40853/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40853/tests/kraken/driver.html?testName=ai-astar) 19:21:21 INFO - 2015-12-02 19:21:21,681 DEBUG : BROWSER_OUTPUT: RSS: Main: 244920320 19:21:21 INFO - 2015-12-02 19:21:21,681 DEBUG : BROWSER_OUTPUT: 19:21:21 INFO - 2015-12-02 19:21:21,681 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:21:21 INFO - 2015-12-02 19:21:21,681 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:21:21 INFO - 2015-12-02 19:21:21,681 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:21:21 INFO - 2015-12-02 19:21:21,682 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:21:21 INFO - 2015-12-02 19:21:21,682 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;106;112;112;113;100;113;114;103 19:21:21 INFO - 2015-12-02 19:21:21,682 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;129;153;173;131;153;148;129;167;133 19:21:21 INFO - 2015-12-02 19:21:21,682 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;160;162;162;159;159;163;161;160 19:21:21 INFO - 2015-12-02 19:21:21,682 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;86;97;71;71;75;111;89;71 19:21:21 INFO - 2015-12-02 19:21:21,682 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;125;94;94;94;126;94;94;126 19:21:21 INFO - 2015-12-02 19:21:21,682 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;111;110;109;109;109;110;111;110 19:21:21 INFO - 2015-12-02 19:21:21,682 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;147;146;146;146;148;146;147 19:21:21 INFO - 2015-12-02 19:21:21,682 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;98;97;95;97;97;96;96 19:21:21 INFO - 2015-12-02 19:21:21,682 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;71;72;72;71;71;72;74;73;69 19:21:21 INFO - 2015-12-02 19:21:21,683 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;67;68;69;68;68;68;68;68;69 19:21:21 INFO - 2015-12-02 19:21:21,683 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;81;84;83;82;83;83;83;82;83 19:21:21 INFO - 2015-12-02 19:21:21,683 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;120;129;129;129;129;125;122;127;125 19:21:21 INFO - 2015-12-02 19:21:21,683 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;136;148;150;148;139;147;148;147;136 19:21:21 INFO - 2015-12-02 19:21:21,683 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;77;68;67;68;75;67;68;69;67;70 19:21:21 INFO - 2015-12-02 19:21:21,683 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:21:21 INFO - 2015-12-02 19:21:21,683 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:21:21 INFO - 2015-12-02 19:21:21,683 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1002 19:21:21 INFO - 2015-12-02 19:21:21,684 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:21:21 INFO - 2015-12-02 19:21:21,684 DEBUG : BROWSER_OUTPUT: __startTimestamp1449112881676__endTimestamp 19:21:21 INFO - 2015-12-02 19:21:21,684 DEBUG : BROWSER_OUTPUT: 19:21:21 INFO - 2015-12-02 19:21:21,684 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:21:21 INFO - 2015-12-02 19:21:21,684 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:21:21 INFO - 2015-12-02 19:21:21,684 DEBUG : BROWSER_OUTPUT: 19:21:21 INFO - 2015-12-02 19:21:21,684 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.60 Median:112.00 stddev:4.84 (4.3%) stddev-sans-first:5.10 19:21:21 INFO - 2015-12-02 19:21:21,684 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 106.0 112.0 112.0 113.0 100.0 113.0 114.0 103.0 19:21:21 INFO - 2015-12-02 19:21:21,684 DEBUG : BROWSER_OUTPUT: 19:21:21 INFO - 2015-12-02 19:21:21,685 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.10 Median:153.00 stddev:16.03 (10.5%) stddev-sans-first:16.75 19:21:21 INFO - 2015-12-02 19:21:21,685 DEBUG : BROWSER_OUTPUT: Values: 155.0 129.0 153.0 173.0 131.0 153.0 148.0 129.0 167.0 133.0 19:21:21 INFO - 2015-12-02 19:21:21,685 DEBUG : BROWSER_OUTPUT: 19:21:21 INFO - 2015-12-02 19:21:21,686 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.34 (0.8%) stddev-sans-first:1.39 19:21:21 INFO - 2015-12-02 19:21:21,686 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 160.0 162.0 162.0 159.0 159.0 163.0 161.0 160.0 19:21:21 INFO - 2015-12-02 19:21:21,686 DEBUG : BROWSER_OUTPUT: 19:21:21 INFO - 2015-12-02 19:21:21,686 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.50 Median:73.50 stddev:13.91 (18.9%) stddev-sans-first:14.32 19:21:21 INFO - 2015-12-02 19:21:21,686 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 86.0 97.0 71.0 71.0 75.0 111.0 89.0 71.0 19:21:21 INFO - 2015-12-02 19:21:21,687 DEBUG : BROWSER_OUTPUT: 19:21:21 INFO - 2015-12-02 19:21:21,687 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.60 Median:94.00 stddev:15.23 (16.2%) stddev-sans-first:15.84 19:21:21 INFO - 2015-12-02 19:21:21,687 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 125.0 94.0 94.0 94.0 126.0 94.0 94.0 126.0 19:21:21 INFO - 2015-12-02 19:21:21,687 DEBUG : BROWSER_OUTPUT: 19:21:21 INFO - 2015-12-02 19:21:21,687 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 19:21:21 INFO - 2015-12-02 19:21:21,687 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 111.0 110.0 109.0 109.0 109.0 110.0 111.0 110.0 19:21:21 INFO - 2015-12-02 19:21:21,687 DEBUG : BROWSER_OUTPUT: 19:21:21 INFO - 2015-12-02 19:21:21,687 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 19:21:21 INFO - 2015-12-02 19:21:21,687 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 147.0 146.0 146.0 146.0 148.0 146.0 147.0 19:21:21 INFO - 2015-12-02 19:21:21,687 DEBUG : BROWSER_OUTPUT: 19:21:21 INFO - 2015-12-02 19:21:21,687 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.95 (1.0%) stddev-sans-first:1.00 19:21:21 INFO - 2015-12-02 19:21:21,688 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 98.0 97.0 95.0 97.0 97.0 96.0 96.0 19:21:21 INFO - 2015-12-02 19:21:21,688 DEBUG : BROWSER_OUTPUT: 19:21:21 INFO - 2015-12-02 19:21:21,688 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.60 Median:72.00 stddev:1.35 (1.9%) stddev-sans-first:1.41 19:21:21 INFO - 2015-12-02 19:21:21,688 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 72.0 72.0 71.0 71.0 72.0 74.0 73.0 69.0 19:21:21 INFO - 2015-12-02 19:21:21,688 DEBUG : BROWSER_OUTPUT: 19:21:21 INFO - 2015-12-02 19:21:21,688 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 19:21:21 INFO - 2015-12-02 19:21:21,688 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 68.0 69.0 68.0 68.0 68.0 68.0 68.0 69.0 19:21:21 INFO - 2015-12-02 19:21:21,688 DEBUG : BROWSER_OUTPUT: 19:21:21 INFO - 2015-12-02 19:21:21,688 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:0.84 (1.0%) stddev-sans-first:0.87 19:21:21 INFO - 2015-12-02 19:21:21,688 DEBUG : BROWSER_OUTPUT: Values: 82.0 81.0 84.0 83.0 82.0 83.0 83.0 83.0 82.0 83.0 19:21:21 INFO - 2015-12-02 19:21:21,688 DEBUG : BROWSER_OUTPUT: 19:21:21 INFO - 2015-12-02 19:21:21,689 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:128.00 stddev:3.25 (2.5%) stddev-sans-first:3.37 19:21:21 INFO - 2015-12-02 19:21:21,689 DEBUG : BROWSER_OUTPUT: Values: 124.0 120.0 129.0 129.0 129.0 129.0 125.0 122.0 127.0 125.0 19:21:21 INFO - 2015-12-02 19:21:21,689 DEBUG : BROWSER_OUTPUT: 19:21:21 INFO - 2015-12-02 19:21:21,689 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.70 Median:147.50 stddev:5.68 (3.8%) stddev-sans-first:5.63 19:21:21 INFO - 2015-12-02 19:21:21,689 DEBUG : BROWSER_OUTPUT: Values: 138.0 136.0 148.0 150.0 148.0 139.0 147.0 148.0 147.0 136.0 19:21:21 INFO - 2015-12-02 19:21:21,689 DEBUG : BROWSER_OUTPUT: 19:21:21 INFO - 2015-12-02 19:21:21,689 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:68.50 stddev:3.53 (5.2%) stddev-sans-first:2.54 19:21:21 INFO - 2015-12-02 19:21:21,689 DEBUG : BROWSER_OUTPUT: Values: 77.0 68.0 67.0 68.0 75.0 67.0 68.0 69.0 67.0 70.0 19:21:21 INFO - 2015-12-02 19:21:21,689 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:21:21 INFO - 2015-12-02 19:21:21,689 DEBUG : BROWSER_OUTPUT: 19:21:22 INFO - 2015-12-02 19:21:22,593 INFO : Browser exited with error code: 0 19:21:22 INFO - 2015-12-02 19:21:22,644 INFO : Completed test kraken (00:01:00) 19:21:22 INFO - 2015-12-02 19:21:22,644 INFO : Starting test v8_7 19:21:22 INFO - 2015-12-02 19:21:22,644 DEBUG : operating with platform_type : linux_ 19:21:22 INFO - 2015-12-02 19:21:22,644 INFO : Initialising browser for v8_7 test... 19:21:22 INFO - 2015-12-02 19:21:22,650 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqMFyUf/profile http://localhost:40853/getInfo.html 19:21:26 INFO - 2015-12-02 19:21:26,632 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:21:26 INFO - 2015-12-02 19:21:26,633 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:21:26 INFO - 2015-12-02 19:21:26,633 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:21:26 INFO - 2015-12-02 19:21:26,633 DEBUG : BROWSER_OUTPUT: __metrics 19:21:26 INFO - 2015-12-02 19:21:26,802 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:21:28 INFO - 2015-12-02 19:21:28,019 INFO : Browser initialized. 19:21:28 INFO - 2015-12-02 19:21:28,020 INFO : Running cycle 1/1 for v8_7 test... 19:21:28 INFO - 2015-12-02 19:21:28,020 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqMFyUf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:21:39 INFO - 2015-12-02 19:21:39,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 146006016 19:21:39 INFO - 2015-12-02 19:21:39,919 DEBUG : BROWSER_OUTPUT: 19:22:01 INFO - 2015-12-02 19:22:01,335 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40853/tests/v8_7/run.html (next: http://localhost:40853/tests/v8_7/run.html) 19:22:01 INFO - 2015-12-02 19:22:01,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 448573440 19:22:01 INFO - 2015-12-02 19:22:01,585 DEBUG : BROWSER_OUTPUT: 19:22:01 INFO - 2015-12-02 19:22:01,585 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:22:01 INFO - 2015-12-02 19:22:01,585 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:22:01 INFO - 2015-12-02 19:22:01,586 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:22:01 INFO - 2015-12-02 19:22:01,586 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:22:01 INFO - 2015-12-02 19:22:01,586 DEBUG : BROWSER_OUTPUT: |0;Richards;165.39861065167054 19:22:01 INFO - 2015-12-02 19:22:01,586 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.3143294432753 19:22:01 INFO - 2015-12-02 19:22:01,587 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.55153203342616 19:22:01 INFO - 2015-12-02 19:22:01,587 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5138.461538461538 19:22:01 INFO - 2015-12-02 19:22:01,587 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2014.0845070422536 19:22:01 INFO - 2015-12-02 19:22:01,587 DEBUG : BROWSER_OUTPUT: |5;Earley;796.9745222929936 19:22:01 INFO - 2015-12-02 19:22:01,587 DEBUG : BROWSER_OUTPUT: |6;Boyer;12345.67901234568 19:22:01 INFO - 2015-12-02 19:22:01,588 DEBUG : BROWSER_OUTPUT: |7;RegExp;26205.128205128207 19:22:01 INFO - 2015-12-02 19:22:01,588 DEBUG : BROWSER_OUTPUT: |8;Splay;597.2797161442933 19:22:01 INFO - 2015-12-02 19:22:01,588 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4859.223300970873 19:22:01 INFO - 2015-12-02 19:22:01,588 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:22:01 INFO - 2015-12-02 19:22:01,589 DEBUG : BROWSER_OUTPUT: __startTimestamp1449112921584__endTimestamp 19:22:01 INFO - 2015-12-02 19:22:01,589 DEBUG : BROWSER_OUTPUT: 19:22:01 INFO - 2015-12-02 19:22:01,589 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:22:01 INFO - 2015-12-02 19:22:01,590 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:22:01 INFO - 2015-12-02 19:22:01,590 DEBUG : BROWSER_OUTPUT: 19:22:01 INFO - 2015-12-02 19:22:01,590 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.40 Median:165.40 stddev:0.00 (0.0%) 19:22:01 INFO - 2015-12-02 19:22:01,590 DEBUG : BROWSER_OUTPUT: Values: 165.4 19:22:01 INFO - 2015-12-02 19:22:01,591 DEBUG : BROWSER_OUTPUT: 19:22:01 INFO - 2015-12-02 19:22:01,591 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.31 Median:191.31 stddev:0.00 (0.0%) 19:22:01 INFO - 2015-12-02 19:22:01,591 DEBUG : BROWSER_OUTPUT: Values: 191.3 19:22:01 INFO - 2015-12-02 19:22:01,591 DEBUG : BROWSER_OUTPUT: 19:22:01 INFO - 2015-12-02 19:22:01,592 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.55 Median:278.55 stddev:0.00 (0.0%) 19:22:01 INFO - 2015-12-02 19:22:01,592 DEBUG : BROWSER_OUTPUT: Values: 278.6 19:22:01 INFO - 2015-12-02 19:22:01,592 DEBUG : BROWSER_OUTPUT: 19:22:01 INFO - 2015-12-02 19:22:01,593 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5138.46 Median:5138.46 stddev:0.00 (0.0%) 19:22:01 INFO - 2015-12-02 19:22:01,593 DEBUG : BROWSER_OUTPUT: Values: 5138.5 19:22:01 INFO - 2015-12-02 19:22:01,593 DEBUG : BROWSER_OUTPUT: 19:22:01 INFO - 2015-12-02 19:22:01,593 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2014.08 Median:2014.08 stddev:0.00 (0.0%) 19:22:01 INFO - 2015-12-02 19:22:01,593 DEBUG : BROWSER_OUTPUT: Values: 2014.1 19:22:01 INFO - 2015-12-02 19:22:01,593 DEBUG : BROWSER_OUTPUT: 19:22:01 INFO - 2015-12-02 19:22:01,593 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:796.97 Median:796.97 stddev:0.00 (0.0%) 19:22:01 INFO - 2015-12-02 19:22:01,594 DEBUG : BROWSER_OUTPUT: Values: 797.0 19:22:01 INFO - 2015-12-02 19:22:01,594 DEBUG : BROWSER_OUTPUT: 19:22:01 INFO - 2015-12-02 19:22:01,594 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 19:22:01 INFO - 2015-12-02 19:22:01,594 DEBUG : BROWSER_OUTPUT: Values: 12345.7 19:22:01 INFO - 2015-12-02 19:22:01,594 DEBUG : BROWSER_OUTPUT: 19:22:01 INFO - 2015-12-02 19:22:01,594 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26205.13 Median:26205.13 stddev:0.00 (0.0%) 19:22:01 INFO - 2015-12-02 19:22:01,594 DEBUG : BROWSER_OUTPUT: Values: 26205.1 19:22:01 INFO - 2015-12-02 19:22:01,594 DEBUG : BROWSER_OUTPUT: 19:22:01 INFO - 2015-12-02 19:22:01,594 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.28 Median:597.28 stddev:0.00 (0.0%) 19:22:01 INFO - 2015-12-02 19:22:01,595 DEBUG : BROWSER_OUTPUT: Values: 597.3 19:22:01 INFO - 2015-12-02 19:22:01,595 DEBUG : BROWSER_OUTPUT: 19:22:01 INFO - 2015-12-02 19:22:01,595 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 19:22:01 INFO - 2015-12-02 19:22:01,595 DEBUG : BROWSER_OUTPUT: Values: 4859.2 19:22:01 INFO - 2015-12-02 19:22:01,595 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:22:01 INFO - 2015-12-02 19:22:01,595 DEBUG : BROWSER_OUTPUT: 19:22:02 INFO - 2015-12-02 19:22:02,469 INFO : Browser exited with error code: 0 19:22:02 INFO - 2015-12-02 19:22:02,486 INFO : Completed test v8_7 (00:00:39) 19:22:02 INFO - 2015-12-02 19:22:02,608 INFO : Completed test suite (00:20:17) 19:22:02 INFO - 2015-12-02 19:22:02,609 DEBUG : Working with test: dromaeo_css 19:22:02 INFO - 2015-12-02 19:22:02,609 DEBUG : Generating results file: dromaeo_css 19:22:02 INFO - 2015-12-02 19:22:02,610 DEBUG : Working with test: kraken 19:22:02 INFO - 2015-12-02 19:22:02,610 DEBUG : Generating results file: kraken 19:22:02 INFO - 2015-12-02 19:22:02,610 INFO : javascript benchmark 19:22:02 INFO - 2015-12-02 19:22:02,610 DEBUG : Working with test: v8_7 19:22:02 INFO - 2015-12-02 19:22:02,611 DEBUG : Generating results file: v8_7 19:22:02 INFO - 2015-12-02 19:22:02,611 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:22:02 INFO - 2015-12-02 19:22:02,677 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,144,35]] 19:22:02 INFO - 2015-12-02 19:22:02,677 DEBUG : process_Request line: dromaeo_css 6254.95 graph.html#tests=[[72,144,35]] 19:22:02 INFO - 2015-12-02 19:22:02,677 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:22:02 INFO - 2015-12-02 19:22:02,718 DEBUG : process_Request line: kraken 1516.90 graph.html#tests=[[232,144,35]] 19:22:02 INFO - 2015-12-02 19:22:02,718 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:22:02 INFO - 2015-12-02 19:22:02,756 DEBUG : process_Request line: v8_7 19768.91 graph.html#tests=[[230,144,35]] 19:22:02 INFO - 2015-12-02 19:22:02,760 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2613.8693065346733, 2729.249456399491, 2737.7003317213535, 2745.4234610731737, 2746.3408781892354, 4386.627136693385, 4515.39042229299, 4677.134730074934, 4716.056788642272, 4721.598664113554, 4626.074785042988, 4658.440987081555, 4740.075685241371, 4741.691790033646, 4784.330193772866, 4316.827326906936, 4318.9784051079705, 4324.84863029794, 4337.501187363462, 4353.978230108845, 4164.437800896871, 4362.760048197348, 4379.868603941887, 4425.31407631816, 4435.135148645999, 4207.978960105211, 4238.512571054337, 4249.065205654751, 4329.112531930947, 4330.588594083557, 4370.300751879684, 4373.343998400233, 4374.387585737999, 4376.256036473776, 4412.801423935931, 4351.369051487548, 4354.891127721832, 4363.040131171169, 4400.405945197389, 4402.581754733327, 4448.221561226773, 4520.163769702615, 4596.057808149355, 4603.148417542765, 4619.74591397473, 4965.528274813887, 5026.623003274733, 5094.694318340874, 5108.157154069611, 5110.259012443212, 5074.13739664258, 5095.872603184913, 5113.181890897438, 5117.257997590328, 5164.819231326923, 4453.643708503312, 4549.363089167519, 4549.385832912581, 4735.2186889163595, 4760.761961901926, 5071.822486212965, 5166.2767212589515, 5167.6641018333685, 5175.197844334134, 5221.269022336875, 4899.755012249373, 4900.2894580286375, 4903.068417000758, 4908.435529914034, 4932.186189278729, 4818.7831547580445, 4930.852074437701, 4973.626977976666, 4983.401991761012, 4993.300937868701, 4909.116359055404, 4959.528844759742, 5085.389753229636, 5096.159133742965, 5105.617078719111, 4939.950600493949, 4983.90032199354, 4984.750762461862, 4986.177280748709, 5008.549230569266, 4227.7463352198965, 4260.510041345285, 4263.4031235627035, 4299.613034826881, 4309.375140604658, 3593.892183234455, 3656.067702735785, 3704.6480584344445, 3715.5912849586525, 3720.1071742781537, 4346.695731298779, 4356.368326592689, 4373.562643735665, 4391.5827996340295, 4405.845795397146, 5054.646174767731, 5058.494150584912, 5058.848234552969, 5069.264956581349, 5099.031184075014, 4184.14225083857, 4274.7435153890865, 4282.8715138545895, 4305.677074219446, 4349.521552629209, 4594.563516465931, 4612.930806037912, 4618.49196588375, 4647.744374059392, 4652.13935421948, 4879.829205977845, 4881.707097574157, 4882.438519570223, 4896.877578060577, 4932.778024988812, 4835.661503694849, 4934.383202099738, 4938.604911606991, 4943.530364615356, 5160.148575485153, 4803.087413391444, 4803.3995750531185, 4811.9518804811505, 4855.6115510758345, 4857.149998750276, 5004.049230646166, 5006.449290578106, 5011.724355160502, 5012.373453318335, 5025.7989680412375, 4871.123197824284, 4932.827351042696, 4981.2030075187795, 4990.525900039491, 5125.79496820123, 4990.975045124751, 4991.3511243538105, 4995.975020124876, 5001.524855138756, 5003.024410239968, 4982.327385802871, 4982.7259500727805, 4991.80032798684, 4995.975020125022, 5029.773660185374, 4491.910161796681, 4665.650076244227, 4668.719876807402, 4744.288356746516, 4929.580985616263, 4967.155583550877, 4977.950220497749, 4985.875353116201, 5008.373953255843, 5021.748912554431, 4854.247591623304, 4854.514548545118, 4867.902641947212, 4868.561829435368, 4902.92645610309], "unit": "ms", "name": "dojo.html", "value": 4625.435019042826}, {"lowerIsBetter": false, "replicates": [544.7412479072441, 554.4483239177019, 566.6996491859314, 573.1631817546381, 575.7639367859178, 26559.4688106238, 27050.45899082017, 36764.81617591915, 37943.0, 38086.428703569465, 41018.38472422916, 41083.38374924371, 41124.794376028076, 41145.79427102868, 41475.792621036926, 6883.621400822953, 7847.293743563078, 7997.840043199132, 8033.317168040723, 8056.033276006888, 6927.411170050552, 10131.189504839633, 10397.844032339483, 10409.947950260275, 10416.166706663487, 10035.648752293671, 10140.49297535124, 10147.797044059114, 10149.39103653783, 10154.0, 7048.894266585954, 7223.1332240131, 10097.192224622013, 10157.898421015843, 10194.235432342604, 9888.208943284591, 10030.749231269203, 10073.496325183785, 10096.394216347042, 10097.798044039078, 37327.813360933294, 37682.434763478566, 37754.244915101546, 37843.4323485148, 37916.43125353122, 2876.367199216169, 3188.266698659298, 3624.4925710400566, 3672.7429079964145, 3713.387291096966, 28407.289817754514, 28415.0, 28644.570331445044, 28666.426671466663, 28709.0, 3456.5333679953137, 3462.497937799005, 3468.5664291963503, 3505.929881402383, 3595.7662751921043, 233425.0, 234094.0, 234251.0, 234288.0, 234465.99999999828, 47542.76228618835, 49338.259926101135, 54068.0, 54435.18347224795, 54480.0, 60508.69745651243, 61968.38031619716, 62218.0, 62242.68878655578, 62298.68850655809, 13230.536931207362, 13344.866551334557, 13406.329683515785, 13406.396712147976, 13427.530036448677, 9882.061204185591, 9959.302848800515, 9977.650782222587, 9981.201503879673, 10004.54979525923, 17853.7321940171, 18101.818981810276, 18106.728399074025, 18165.7275140873, 18192.81807181911, 6867.553609015398, 7138.179109402381, 7170.42636589082, 7208.495405321577, 7238.52949558277, 787.4133770341133, 877.806882485852, 954.5847556313026, 974.181687382602, 1014.3457469932, 26010.6098408524, 26538.6019209712, 26585.867070664524, 26956.460870782474, 27127.86436067807, 862.3058437957379, 933.6498812945146, 999.7450650084182, 1064.6060957445795, 1067.8665166854144, 14378.85621143796, 14424.0, 14591.854081459262, 14751.704965900622, 14780.113193208443, 318706.0, 320859.0, 323337.0, 323435.0, 323552.0, 42542.361864572056, 43190.136197275875, 49077.754611226715, 49682.75158624184, 54197.0, 1228.705110773408, 1252.7807633664254, 1259.0871618076822, 1263.5072321794507, 1263.9810402843964, 28219.858900705363, 28805.0, 29132.56301155442, 29630.111096667133, 29681.0, 34680.30639387249, 34785.65214347925, 41901.58098419099, 42514.149717006105, 42565.36151957661, 188831.0, 189959.0, 190770.0, 190926.0, 191037.0, 27801.44397112087, 27871.721282787723, 28029.439411212068, 28081.0, 28162.577561336188, 35513.0, 35826.462603060456, 36022.639773602976, 36696.81651591725, 36724.08189795277, 33024.1743956403, 33255.0, 33926.49110263299, 34462.58761886644, 34701.82649086738, 33704.49443258402, 34380.828095860365, 34518.30963380668, 34595.0, 34758.13104672403, 38637.42043869288, 38717.225655487295, 39130.80434597809, 39408.0, 39695.40456893091, 30239.848800755855, 30989.0, 31345.68654313519, 31347.924769779784, 31454.685453145175, 24208.87895560511, 24537.386565336008, 24543.754562454862, 24838.37904052341, 24921.75078249194], "unit": "ms", "name": "ext.html", "value": 17400.89763113025}, {"lowerIsBetter": false, "replicates": [335.82369256140515, 339.94560870260756, 341.2969283276452, 342.59744799860187, 343.97936123832574, 12257.570985015525, 12864.485420583189, 15423.151726655044, 15454.922725386372, 16041.518754437371, 12731.681707957283, 14622.195779232137, 14703.411863525473, 15072.246387680627, 15079.773803392958, 4871.585915197213, 4940.555350018498, 5070.036693028332, 5094.821681241157, 5098.515641014116, 3536.1513236823107, 3645.143391303042, 5012.899742005157, 5064.696118232918, 5068.5691716204165, 3625.329314076891, 3625.6011838697723, 3628.129248980252, 3629.2922880038404, 5364.088105022136, 5422.728863556846, 5539.584531160159, 5585.888282234373, 5591.41290164533, 5618.073017952033, 4872.3909511311085, 4948.455669876311, 4951.232558953368, 4960.1567733485035, 4960.975195124001, 18910.338138165098, 18996.810031899782, 19005.524861878424, 19042.714359284622, 19677.508062298413, 1713.5544758362792, 1801.7477553142571, 1812.0848971269556, 1885.9905700471547, 1900.4203717866046, 12636.68408289791, 12736.04479664029, 12750.681232969157, 12894.742105157844, 13033.348332583428, 1754.7894252689632, 1777.7866656001233, 1786.6873297172942, 1800.5858652509864, 1803.071418219618, 52407.73796131033, 55098.44901551013, 55470.9999999996, 55728.44271557273, 56228.15657765096, 9396.95301523488, 9475.336726429085, 9522.428654280766, 9647.372920760128, 9680.128788409076, 12267.509299627915, 12290.938545307396, 12298.262104273772, 12317.0, 12335.136540442263, 6699.095622091053, 6754.088198093293, 6784.966075169691, 6850.6574671266235, 6936.271691472423, 6214.751409943642, 6232.906506402408, 6259.374062593704, 6274.874502509924, 6288.213973253343, 5697.0599851024945, 5769.94230057694, 5774.105013722879, 5780.653160810365, 5811.070228763378, 1528.5414375687249, 1594.194931559555, 1635.9509214723578, 1666.258514960855, 1701.948941531756, 808.7290757596271, 880.903100658927, 886.1625763653415, 939.3659279985982, 972.8978457262027, 16162.191890405433, 16278.51164465068, 16296.185190740416, 16603.41888033913, 16662.750058749127, 808.4744915804774, 873.921347078766, 893.4192774696369, 902.2601466797295, 913.2191975860676, 8246.958765206136, 8961.23829474489, 9004.054574269738, 9062.91245050598, 9084.227840633488, 503111.0, 509812.0, 510485.0, 510626.0, 517862.0, 69759.0, 71315.28684713191, 74307.0, 74311.25688743043, 74392.0, 1053.2837670384213, 1064.1327318235612, 1105.2649987758211, 1132.6149109302712, 1137.0789660375124, 13233.933830331172, 13899.235542045284, 14167.291635418394, 14397.568072957829, 14432.85567144357, 31008.0, 31095.844520777253, 31524.527132093495, 32595.0, 32921.0, 37690.623093769806, 39182.0, 39447.605523944396, 40671.38992915049, 45665.543344566126, 8840.160184782435, 9025.323100767337, 9083.954580227057, 9118.863217051618, 9233.399829011092, 10719.410432425979, 10794.352338859379, 10797.838032429363, 10875.564977400816, 16339.183040847673, 13388.19670819754, 13541.864581354454, 13640.727185456037, 13683.384247708678, 14194.92902535522, 13169.144005639602, 13212.273324967218, 13431.664208394868, 13688.726225475633, 13892.791608125684, 10474.0, 12324.445399956845, 13493.662658433617, 13872.930635346758, 14414.567562973127, 9008.954955225181, 9114.817703646022, 9196.0, 9198.356115071882, 9266.814663706822, 9898.604055837974, 10454.0, 13816.861831381959, 14046.227457489937, 14176.362063707364], "unit": "ms", "name": "jquery.html", "value": 8227.263332235823}, {"lowerIsBetter": false, "replicates": [1357.6130802721227, 1559.2359743725572, 1611.1541440743608, 1619.101398723708, 1638.6968410844001, 5700.515456186224, 6674.466042716583, 6847.828804279896, 6852.109225800646, 6862.382385585309, 6803.489738269637, 6929.925861491464, 6963.547369420997, 6975.128108986377, 7000.684969176386, 1732.7141021731463, 1766.6731654643868, 2047.8361731061555, 2053.045333919727, 2095.3713885834263, 2101.695254188142, 2110.7783682713325, 2116.0689296709397, 2118.205672872673, 2118.692789545515, 2033.2375359240284, 2033.2578608807826, 2076.7923207679187, 2080.3758872338312, 2083.8437117216267, 2047.2118234479683, 2054.7431571053617, 2077.937661870139, 2079.261862038977, 2092.3199960012903, 2071.6892466130053, 2076.4705000224844, 2081.906314215849, 2087.84341174411, 2091.633964056299, 6299.622022678654, 6361.01404282337, 6362.522810789209, 6365.331640177761, 6381.329960354189, 4041.73728707636, 4099.1801639672185, 4141.730787498803, 4145.295299799011, 4149.91700165995, 2273.89767460463, 2664.507066192741, 2757.7931655125944, 2769.127724766692, 2780.986095069532, 766.295008592091, 813.4184058398215, 874.4753148111146, 905.6830109461702, 922.7324076017946, 8943.731688049369, 9001.684941027033, 9026.86459703105, 9027.503487308195, 9056.773580660536, 3884.2425726983533, 3924.862629807943, 3960.544537378181, 3984.86052988144, 3997.560268370477, 7860.410469214832, 7865.646045927947, 7878.290953814184, 7898.170692077249, 7901.960490197627, 4128.752274863517, 4130.401091841726, 4131.215069136854, 4138.875833724993, 4140.68944829139, 3779.149691319486, 3779.3008293465796, 3781.8676346327748, 3782.394816829294, 3792.7534710243744, 2802.103326935361, 2847.245479947774, 3015.5627434021944, 3061.127578640077, 3237.4658181399805, 1090.1006669497538, 1094.1684319916762, 1098.3519723363254, 1107.5237647811357, 1114.2590177532013, 852.7015544559355, 853.0616322045701, 856.6316483911853, 884.7832281091174, 997.670768646345, 6315.747370105236, 6347.96826015867, 6371.49028077762, 6380.457661098859, 6381.266154392211, 996.8953259907605, 1002.7994401119805, 1024.2676486312323, 1029.3360782295379, 1034.2811745836723, 4945.109880221523, 4953.826616068421, 4985.102681517362, 4997.175466048134, 5001.474845141281, 7769.300762931363, 7955.323797477164, 8034.397420193509, 8040.597970101471, 8110.432269741062, 7940.364770818321, 8036.316913062456, 8046.0, 8060.717874874468, 8132.5933703314595, 6240.063990401385, 6350.142730731384, 6365.713542890581, 6373.553851230369, 6384.3934826191435, 5840.649561026352, 6038.184845045863, 6047.909281360695, 6055.0, 6062.393760623902, 7088.0, 7176.712931482891, 7193.928060719326, 7251.456140789567, 7262.055932728923, 7225.349718525358, 7345.192028876926, 7381.298776616428, 7424.220456852169, 7429.219931907072, 5672.319321681424, 5747.798827041033, 5757.280339957505, 5775.537956963349, 5777.133429985536, 5435.510804027656, 5577.553795696415, 5833.649981001154, 6245.406686364788, 6324.588901721373, 5879.470847623735, 5907.645541267538, 6095.0, 6125.632462052291, 6156.630602163885, 5649.067903795828, 5654.236678048575, 5709.800156994652, 5917.201177840936, 6057.969710151421, 6087.9391206087375, 6097.817065488042, 6113.908291375544, 6142.969285153546, 6153.661548614869, 5436.6194366393975, 5568.9443105568425, 5569.0254205513065, 5590.357108932362, 5593.496585307342, 5674.375818660027, 5731.168980497888, 5737.770489180386, 5738.913916291175, 5758.078707406795], "unit": "ms", "name": "mootools.html", "value": 3900.189740293848}, {"lowerIsBetter": false, "replicates": [312.5811412706973, 313.02024662805417, 321.3572854291417, 325.36066629073866, 328.11736429005987, 5208.0, 5237.84286471406, 5346.27825243592, 5405.18922161676, 5425.159100339449, 5160.406553246377, 5301.1783173608055, 5320.733963301839, 5327.200919862023, 5330.773921997943, 3962.385830196324, 4052.128792309653, 4178.832846686137, 4187.602177793105, 4196.62230399264, 4049.1496785675045, 4124.876253712393, 4137.979310103446, 4142.047329114305, 4145.481814773153, 4085.2850751118435, 4085.46888904442, 4124.443200167984, 4126.525449573308, 4141.151064031867, 4127.442795222667, 4134.317837556815, 4141.109661422778, 4143.647789937859, 4143.792810359485, 3615.168511242429, 3619.0047736872307, 3619.2580520993133, 3620.9275814483826, 3629.5281613390353, 4953.504649535053, 5064.290999260106, 5074.847754567369, 5075.314832497639, 5092.083424983502, 4735.12400205963, 4736.123817093849, 4741.9288710669025, 4754.120487709784, 4755.405574303212, 5334.413214546396, 5579.549317177522, 5585.748641311151, 5592.944070559283, 5600.971995140039, 3797.4493698413853, 3842.8270727817317, 3968.523777146732, 3972.8808135755685, 3975.1453437510786, 5819.185314056035, 5878.912401205748, 5936.198613187207, 5942.673152976585, 5943.970280148572, 4068.6338229559483, 4071.531773845986, 4073.51117865858, 4076.8573099941955, 4077.1641813428178, 4040.0303927057294, 4126.339785634284, 4128.4632997710705, 4132.462779838602, 4132.690048246333, 4734.905301894012, 4743.810247590127, 4745.1695953208055, 4746.027064451848, 4753.215719406328, 5655.0, 5655.462731040545, 5658.236138121383, 5665.915011274834, 5666.376698563155, 1443.235085404716, 1460.4377314733692, 1469.390203065737, 1469.419579266184, 1469.9853001470062, 987.2990176974286, 989.7575094101991, 992.6575331510618, 1006.8036732837027, 1013.4223492609142, 4970.90058198834, 4976.776045077981, 4981.551660350586, 4982.0, 4989.625778066587, 5860.882782344414, 5862.208601838783, 5867.794627188028, 5868.559858010666, 5869.735861886225, 4953.950460495349, 4970.030843985461, 4970.65205435616, 4970.90058198834, 4978.10394129053, 3090.474619314722, 3138.5292206169256, 3164.7626428017993, 3167.714905658456, 3169.6196456424914, 5538.667679939216, 5543.916841247385, 5547.750351234205, 5550.611457198038, 5551.278333816659, 6000.609960352563, 6009.849753756191, 6014.037753959433, 6017.819465416044, 6021.6989150542295, 5398.08232600451, 5508.586855985817, 5512.0905050667, 5522.420145884785, 5531.474509921551, 5792.4497172768515, 5825.097109947965, 5827.271591051119, 5830.47525722687, 5833.708314584339, 5508.862278443071, 5630.95827271956, 5679.403662615531, 5780.913286300624, 5788.044972579645, 5554.1391084381985, 5563.582731295088, 5566.91649625264, 5569.582281328835, 5578.944210557843, 4065.0853557949226, 4065.4918135233097, 4065.796710164421, 4069.308217602955, 4072.6131017553284, 5689.431056894277, 5886.411358864079, 5889.911651325319, 5896.882062358814, 5916.615419997686, 5652.773889044557, 5682.6306290091015, 5683.232763576864, 5686.886262274648, 5696.458836410535, 5647.632903861236, 5682.715864206856, 5686.09022556389, 5690.914636280542, 5694.487496125203, 5359.651622644516, 5580.2466666999435, 5580.497755202051, 5581.10702287632, 5581.5255703265675, 5714.9142762857755, 5720.0, 5722.62802917809, 5726.112452569859, 5731.369549349485, 5580.135079062752, 5585.0, 5587.469190426903, 5588.608797384307, 5589.385167631639], "unit": "ms", "name": "prototype.html", "value": 4244.066239439701}, {"lowerIsBetter": false, "replicates": [601.9367966363529, 659.9868002639947, 660.9041688955099, 697.9391325185716, 716.1549371741346, 11327.0, 11405.600803971862, 11411.54353825847, 11416.42917854106, 11424.485898134582, 11323.0, 11372.090232781378, 11726.648200553976, 11758.470868810902, 11821.0, 579.5942840011987, 580.7967211475992, 755.2070326157526, 771.0747103475824, 771.1555846348268, 764.3235736373294, 773.2383602151876, 777.059757693192, 783.3967844759532, 783.6199443270039, 793.6666600028002, 805.3718099882101, 807.5477732469807, 807.5962018990505, 807.8505476486839, 607.331934871642, 627.4196368359272, 799.7560743973086, 800.1438460846896, 814.0638265994095, 601.5097695378253, 602.3374288282897, 602.7016626769777, 602.7528713227556, 602.7860109661095, 11123.55393798801, 11129.666110016713, 11229.3262404256, 11243.887561124448, 11249.718757031058, 11377.431128443544, 11423.828642570368, 11592.826107608393, 11639.534418623245, 11711.297322160612, 9087.545622718837, 9111.362204645677, 9151.954240228757, 9198.402103863227, 9198.586063627154, 3229.289556297611, 3241.7892836965757, 3282.917927051819, 3302.9834850825832, 3327.7504187185814, 40145.197096058204, 40320.596794031975, 40737.18525629501, 40800.18399632021, 40823.7958810207, 8722.65109395617, 8915.73252802417, 9279.536321945632, 9323.067693230623, 9422.34043616954, 16102.919485402497, 16215.83784162167, 16227.918860405622, 16242.67514649724, 16317.918410407872, 6116.724747386378, 6207.0, 6307.24313082433, 6396.1045453636525, 6414.069959855888, 3479.7912125272564, 3633.6366363363454, 3705.5738590061947, 3721.423179407196, 3722.3671975763646, 2644.656194694677, 2681.356474446158, 2682.1417146513318, 2683.0475181310744, 2684.2752456836934, 474.44016061048296, 481.2949029671548, 482.1947347928967, 484.8012314950924, 488.1506179248154, 389.7856179101483, 395.8317714971126, 416.2943810241611, 418.56260208082625, 468.54082998661505, 6678.666066696645, 6774.187097548326, 6857.657117144123, 6972.895406568906, 7045.0, 376.05047255679625, 405.062280819901, 434.3311300597045, 441.67265072448237, 562.2493970549363, 3234.8706051758136, 3423.726101911891, 3465.5494785678206, 3530.452779819132, 3530.9578715068865, 49641.255381169314, 50414.0, 50449.0, 50691.74654126706, 50789.49210507922, 44472.555274446844, 44567.554324456985, 44669.77665111719, 44816.77591612086, 45038.0, 39214.80392598019, 39734.0, 40761.79619101885, 41216.0, 41455.7927210362, 7290.526115802456, 7498.887516687363, 7609.124950630527, 7817.648205830637, 8088.433809633269, 29854.850725746233, 30778.076657700305, 31005.379892402478, 31313.0, 32117.6788232124, 38997.41503877387, 39095.04524773693, 39802.80098599489, 40198.0, 40792.59207407888, 9214.631414743335, 9344.906550934404, 9612.423254604746, 9805.21558275322, 9843.557039933363, 10811.189160812813, 10837.566497340018, 10874.29317094418, 10925.781484370109, 10943.835842462211, 9875.20998320147, 10054.29619926598, 10251.436171010666, 10292.176625870063, 10559.736006599896, 10088.54601542947, 10202.744931376776, 10315.27793054479, 10353.792924141626, 10512.316699414514, 9046.185843274137, 9458.148766611039, 10257.384556926609, 10339.948300258451, 10617.256792024484, 8365.24712775853, 8544.0, 8554.657813687383, 8579.65681372763, 8680.479171249744, 8445.324374049938, 8537.542295370386, 8665.566721663765, 8668.523231222343, 8761.342899282707], "unit": "ms", "name": "yui.html", "value": 5463.169670387602}], "name": "dromaeo_css"}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 106.0, 112.0, 112.0, 113.0, 100.0, 113.0, 114.0, 103.0], "unit": "ms", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [155.0, 129.0, 153.0, 173.0, 131.0, 153.0, 148.0, 129.0, 167.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 162.0, 162.0, 159.0, 159.0, 163.0, 161.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 86.0, 97.0, 71.0, 71.0, 75.0, 111.0, 89.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 125.0, 94.0, 94.0, 94.0, 126.0, 94.0, 94.0, 126.0], "unit": "ms", "name": "audio-oscillator", "value": 103.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 110.0, 109.0, 109.0, 109.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 148.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 98.0, 97.0, 95.0, 97.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 72.0, 72.0, 71.0, 71.0, 72.0, 74.0, 73.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.6}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 84.0, 83.0, 82.0, 83.0, 83.0, 83.0, 82.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [124.0, 120.0, 129.0, 129.0, 129.0, 129.0, 125.0, 122.0, 127.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.9}, {"lowerIsBetter": true, "replicates": [138.0, 136.0, 148.0, 150.0, 148.0, 139.0, 147.0, 148.0, 147.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.7}, {"lowerIsBetter": true, "replicates": [77.0, 68.0, 67.0, 68.0, 75.0, 67.0, 68.0, 69.0, 67.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.6}], "name": "kraken"}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.39861065167054], "unit": "score", "name": "Richards", "value": 213.43589200000002}, {"lowerIsBetter": false, "replicates": [191.3143294432753], "unit": "score", "name": "DeltaBlue", "value": 345.5987859999999}, {"lowerIsBetter": false, "replicates": [278.55153203342616], "unit": "score", "name": "Encrypt", "value": 955.5897900000004}, {"lowerIsBetter": false, "replicates": [5138.461538461538], "unit": "score", "name": "Decrypt", "value": 51.80169161676644}, {"lowerIsBetter": false, "replicates": [2014.0845070422536], "unit": "score", "name": "RayTrace", "value": 367.4071258741258}, {"lowerIsBetter": false, "replicates": [796.9745222929936], "unit": "score", "name": "Earley", "value": 836.2412867132866}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [26205.128205128207], "unit": "score", "name": "RegExp", "value": 34.76361545988257}, {"lowerIsBetter": false, "replicates": [597.2797161442933], "unit": "score", "name": "Splay", "value": 136.43691188118814}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7"}]} 19:22:02 INFO - RETURN: dromaeo_css: 6254.95 19:22:02 INFO - RETURN: kraken: 1516.90 19:22:02 INFO - RETURN: v8_7: 19768.91 19:22:02 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,144,35]]", "result": "19768.91"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,144,35]]", "result": "1516.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,144,35]]", "result": "6254.95"}}} 19:22:02 INFO - Return code: 0 19:22:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:22:02 INFO - # TBPL SUCCESS # 19:22:02 INFO - Running post-action listener: _resource_record_post_action 19:22:02 INFO - Running post-run listener: _resource_record_post_run 19:22:03 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 417792; Write bytes: 327831552; Read time: 192; Write time: 223040 19:22:03 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9420800; Read time: 0; Write time: 1548 19:22:03 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 413696; Write bytes: 313761792; Read time: 180; Write time: 220720 19:22:03 INFO - Running post-run listener: _upload_blobber_files 19:22:03 INFO - Blob upload gear active. 19:22:03 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:22:03 INFO - Copying logs to upload dir... 19:22:03 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1265.944109 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-02 19:22:04.035925) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 19:22:04.039585) ========= 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=a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010107 build_url: 'https://queue.taskcluster.net/v1/task/dS-xoHNcRnSLuywGOh3O7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 19:22:04.091278) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 19:22:04.091660) ========= 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=a65b340e283ce644d68cb24e000001c9-1449111654.644515-1313794977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 19:22:04.141785) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 19:22:04.142112) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 19:22:04.142446) ========= ========= Total master_lag: 0.22 =========