builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1448544039.5 results: success (0) buildid: 20151126044312 builduid: 89c8257be1614b60a62dc7053d1dd89b revision: 4aad8e3db7e990ccd2dfc6e7840632559272b22b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 05:20:39.499547) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 05:20:39.500055) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 05:20:39.500378) ========= 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=e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.003013 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 05:20:39.545851) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 05:20:39.546223) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 05:20:39.565327) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 05:20:39.565729) ========= 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=e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004749 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 05:20:39.615631) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 05:20:39.615999) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 05:20:39.616414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 05:20:39.616721) ========= 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=e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-26 05:20:39-- 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% 218M=0s 2015-11-26 05:20:39 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.287038 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 05:20:39.917395) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 05:20:39.917721) ========= 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=e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.125641 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 05:20:40.063409) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 05:20:40.063836) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4aad8e3db7e990ccd2dfc6e7840632559272b22b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4aad8e3db7e990ccd2dfc6e7840632559272b22b --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=e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-26 05:20:40,144 truncating revision to first 12 chars 2015-11-26 05:20:40,144 Setting DEBUG logging. 2015-11-26 05:20:40,144 attempt 1/10 2015-11-26 05:20:40,144 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4aad8e3db7e9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-26 05:20:40,402 unpacking tar archive at: fx-team-4aad8e3db7e9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.551778 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 05:20:40.631364) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 05:20:40.631804) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 05:20:40.643571) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 05:20:40.643976) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 05:20:40.644520) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-26 05:20:40.645272) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:20:40 INFO - MultiFileLogger online at 20151126 05:20:40 in /builds/slave/test 05:20:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:20:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:20:40 INFO - {'append_to_log': False, 05:20:40 INFO - 'base_work_dir': '/builds/slave/test', 05:20:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:20:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:20:40 INFO - 'branch': 'Fx-Team-Non-PGO', 05:20:40 INFO - 'buildbot_json_path': 'buildprops.json', 05:20:40 INFO - 'config_files': ('talos/linux_config.py',), 05:20:40 INFO - 'default_actions': ('clobber', 05:20:40 INFO - 'read-buildbot-config', 05:20:40 INFO - 'download-and-extract', 05:20:40 INFO - 'populate-webroot', 05:20:40 INFO - 'create-virtualenv', 05:20:40 INFO - 'install', 05:20:40 INFO - 'run-tests'), 05:20:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:20:40 INFO - 'download_minidump_stackwalk': True, 05:20:40 INFO - 'download_symbols': 'ondemand', 05:20:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:20:40 INFO - 'tooltool.py': '/tools/tooltool.py', 05:20:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:20:40 INFO - '/tools/misc-python/virtualenv.py')}, 05:20:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:20:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:20:40 INFO - 'installer_path': 'installer.exe', 05:20:40 INFO - 'log_level': 'info', 05:20:40 INFO - 'log_name': 'talos', 05:20:40 INFO - 'log_to_console': True, 05:20:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:20:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:20:40 INFO - 'opt_config_files': (), 05:20:40 INFO - 'pip_index': False, 05:20:40 INFO - 'sps_profile': False, 05:20:40 INFO - 'sps_profile_interval': 0, 05:20:40 INFO - 'suite': 'dromaeojs', 05:20:40 INFO - 'system_bits': '64', 05:20:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:20:40 INFO - 'title': 'talos-linux64-ix-023', 05:20:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:20:40 INFO - 'use_talos_json': True, 05:20:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:20:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:20:40 INFO - 'work_dir': 'build'} 05:20:40 INFO - ##### 05:20:40 INFO - ##### Running clobber step. 05:20:40 INFO - ##### 05:20:40 INFO - Running pre-action listener: _resource_record_pre_action 05:20:40 INFO - Running main action method: clobber 05:20:40 INFO - rmtree: /builds/slave/test/build 05:20:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:20:42 INFO - Running post-action listener: _resource_record_post_action 05:20:42 INFO - ##### 05:20:42 INFO - ##### Running read-buildbot-config step. 05:20:42 INFO - ##### 05:20:42 INFO - Running pre-action listener: _resource_record_pre_action 05:20:42 INFO - Running main action method: read_buildbot_config 05:20:42 INFO - Using buildbot properties: 05:20:42 INFO - { 05:20:42 INFO - "properties": { 05:20:42 INFO - "buildnumber": 2130, 05:20:42 INFO - "product": "firefox", 05:20:42 INFO - "script_repo_revision": "production", 05:20:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:20:42 INFO - "repository": "", 05:20:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:20:42 INFO - "buildid": "20151126044312", 05:20:42 INFO - "slavename": "talos-linux64-ix-023", 05:20:42 INFO - "pgo_build": "False", 05:20:42 INFO - "basedir": "/builds/slave/test", 05:20:42 INFO - "project": "", 05:20:42 INFO - "platform": "ubuntu64_hw", 05:20:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:20:42 INFO - "slavebuilddir": "test", 05:20:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:20:42 INFO - "branch": "fx-team", 05:20:42 INFO - "repo_path": "integration/fx-team", 05:20:42 INFO - "stage_platform": "linux64", 05:20:42 INFO - "builduid": "89c8257be1614b60a62dc7053d1dd89b", 05:20:42 INFO - "revision": "4aad8e3db7e990ccd2dfc6e7840632559272b22b" 05:20:42 INFO - }, 05:20:42 INFO - "sourcestamp": { 05:20:42 INFO - "repository": "", 05:20:42 INFO - "hasPatch": false, 05:20:42 INFO - "project": "", 05:20:42 INFO - "branch": "fx-team-linux64-talos", 05:20:42 INFO - "changes": [ 05:20:42 INFO - { 05:20:42 INFO - "category": null, 05:20:42 INFO - "files": [ 05:20:42 INFO - { 05:20:42 INFO - "url": null, 05:20:42 INFO - "name": "https://queue.taskcluster.net/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:20:42 INFO - } 05:20:42 INFO - ], 05:20:42 INFO - "repository": "", 05:20:42 INFO - "rev": "4aad8e3db7e990ccd2dfc6e7840632559272b22b", 05:20:42 INFO - "who": "dgottwald@mozilla.com", 05:20:42 INFO - "when": 1448543976, 05:20:42 INFO - "number": 6710747, 05:20:42 INFO - "comments": "Bug 384336 - Maximize the browser window on first run on small screens. r=MattN", 05:20:42 INFO - "project": "", 05:20:42 INFO - "at": "Thu 26 Nov 2015 05:19:36", 05:20:42 INFO - "branch": "fx-team-linux64-talos", 05:20:42 INFO - "revlink": "", 05:20:42 INFO - "properties": [ 05:20:42 INFO - [ 05:20:42 INFO - "buildid", 05:20:42 INFO - "20151126044312", 05:20:42 INFO - "Change" 05:20:42 INFO - ], 05:20:42 INFO - [ 05:20:42 INFO - "builduid", 05:20:42 INFO - "89c8257be1614b60a62dc7053d1dd89b", 05:20:42 INFO - "Change" 05:20:42 INFO - ], 05:20:42 INFO - [ 05:20:42 INFO - "pgo_build", 05:20:42 INFO - "False", 05:20:42 INFO - "Change" 05:20:42 INFO - ] 05:20:42 INFO - ], 05:20:42 INFO - "revision": "4aad8e3db7e990ccd2dfc6e7840632559272b22b" 05:20:42 INFO - } 05:20:42 INFO - ], 05:20:42 INFO - "revision": "4aad8e3db7e990ccd2dfc6e7840632559272b22b" 05:20:42 INFO - } 05:20:42 INFO - } 05:20:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:20:42 INFO - Running post-action listener: _resource_record_post_action 05:20:42 INFO - ##### 05:20:42 INFO - ##### Running download-and-extract step. 05:20:42 INFO - ##### 05:20:42 INFO - Running pre-action listener: _resource_record_pre_action 05:20:42 INFO - Running main action method: download_and_extract 05:20:42 INFO - mkdir: /builds/slave/test/build/tests 05:20:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:42 INFO - https://queue.taskcluster.net/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:20:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/test_packages.json 05:20:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/test_packages.json 05:20:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:20:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:20:48 INFO - Downloaded 1302 bytes. 05:20:48 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:20:48 INFO - Using the following test package requirements: 05:20:48 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:20:48 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:20:48 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:48 INFO - u'jsshell-linux-x86_64.zip'], 05:20:48 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:20:48 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:20:48 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:20:48 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:20:48 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:20:48 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:20:48 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:20:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:48 INFO - https://queue.taskcluster.net/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:20:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:20:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:20:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/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 05:20:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/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 05:20:52 INFO - Downloaded 21510200 bytes. 05:20:52 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 05:20:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:20:52 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 05:20:54 INFO - Return code: 0 05:20:54 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 05:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:54 INFO - https://queue.taskcluster.net/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:20:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:20:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:20:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/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 05:20:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/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 05:20:55 INFO - Downloaded 21510200 bytes. 05:20:55 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 05:20:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:20:55 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 05:20:56 INFO - Return code: 0 05:20:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:56 INFO - https://queue.taskcluster.net/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:20:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/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 05:20:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/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 05:20:58 INFO - Downloaded 11131717 bytes. 05:20:58 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 05:20:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:58 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 05:20:58 INFO - Return code: 0 05:20: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')]} 05:20:58 INFO - https://queue.taskcluster.net/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:20:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:20:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:20:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/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 05:20:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/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 05:20:59 INFO - Downloaded 56850825 bytes. 05:20:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:20:59 INFO - mkdir: /builds/slave/test/properties 05:20:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:20:59 INFO - Writing to file /builds/slave/test/properties/build_url 05:20:59 INFO - Contents: 05:20:59 INFO - build_url:https://queue.taskcluster.net/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:20:59 INFO - Running post-action listener: _resource_record_post_action 05:20:59 INFO - Running post-action listener: set_extra_try_arguments 05:20:59 INFO - ##### 05:20:59 INFO - ##### Running populate-webroot step. 05:20:59 INFO - ##### 05:20:59 INFO - Running pre-action listener: _resource_record_pre_action 05:20:59 INFO - Running main action method: populate_webroot 05:20:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:20:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:20:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:20:59 INFO - '../fennec_ids.txt'], 05:20:59 INFO - 'tests': ['tcheck2']}, 05:20:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:20:59 INFO - '--tppagecycles', 05:20:59 INFO - '7'], 05:20:59 INFO - 'tests': ['tsvgm']}}, 05:20:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:20:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:20:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:20:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:20:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:20:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:20:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:59 INFO - 'talos_options': ['--e10s'], 05:20:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:59 INFO - 'tests': ['damp', 'tps']}, 05:20:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:59 INFO - 'talos_options': ['--e10s'], 05:20:59 INFO - 'tests': ['damp', 'tps']}, 05:20:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:20:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:20:59 INFO - 'other': {'tests': ['a11yr', 05:20:59 INFO - 'ts_paint', 05:20:59 INFO - 'tpaint', 05:20:59 INFO - 'sessionrestore', 05:20:59 INFO - 'sessionrestore_no_auto_restore']}, 05:20:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:20:59 INFO - 'tests': ['a11yr', 05:20:59 INFO - 'ts_paint', 05:20:59 INFO - 'tpaint', 05:20:59 INFO - 'sessionrestore', 05:20:59 INFO - 'sessionrestore_no_auto_restore']}, 05:20:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:20:59 INFO - 'tests': ['a11yr', 05:20:59 INFO - 'ts_paint', 05:20:59 INFO - 'tpaint', 05:20:59 INFO - 'sessionrestore', 05:20:59 INFO - 'sessionrestore_no_auto_restore']}, 05:20:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:20:59 INFO - 'tests': ['a11yr', 05:20:59 INFO - 'ts_paint', 05:20:59 INFO - 'tpaint', 05:20:59 INFO - 'sessionrestore', 05:20:59 INFO - 'sessionrestore_no_auto_restore']}, 05:20:59 INFO - 'other_l64': {'tests': ['a11yr', 05:20:59 INFO - 'ts_paint', 05:20:59 INFO - 'tpaint', 05:20:59 INFO - 'sessionrestore', 05:20:59 INFO - 'sessionrestore_no_auto_restore']}, 05:20:59 INFO - 'other_nol64': {'tests': ['a11yr', 05:20:59 INFO - 'ts_paint', 05:20:59 INFO - 'tpaint', 05:20:59 INFO - 'sessionrestore', 05:20:59 INFO - 'sessionrestore_no_auto_restore']}, 05:20:59 INFO - 'svgr': {'tests': ['tsvgx', 05:20:59 INFO - 'tsvgr_opacity', 05:20:59 INFO - 'tart', 05:20:59 INFO - 'tscrollx', 05:20:59 INFO - 'cart']}, 05:20:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:20:59 INFO - 'tests': ['tsvgx', 05:20:59 INFO - 'tsvgr_opacity', 05:20:59 INFO - 'tart', 05:20:59 INFO - 'tscrollx', 05:20:59 INFO - 'cart']}, 05:20:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:59 INFO - 'tests': ['tp5o']}, 05:20:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:59 INFO - 'talos_options': ['--e10s'], 05:20:59 INFO - 'tests': ['tp5o']}, 05:20:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:59 INFO - 'talos_options': ['--xperf_path', 05:20:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:59 INFO - 'tests': ['tp5n']}, 05:20:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:59 INFO - 'talos_options': ['--e10s', 05:20:59 INFO - '--xperf_path', 05:20:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:59 INFO - 'tests': ['tp5n']}}, 05:20:59 INFO - 'talos.zip': {'path': '', 05:20:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:20:59 INFO - Running post-action listener: _resource_record_post_action 05:20:59 INFO - ##### 05:20:59 INFO - ##### Running create-virtualenv step. 05:20:59 INFO - ##### 05:20:59 INFO - Running pre-action listener: _resource_record_pre_action 05:20:59 INFO - Running main action method: create_virtualenv 05:20:59 INFO - Creating virtualenv /builds/slave/test/build/venv 05:20:59 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 05:20:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:20:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:20:59 INFO - Using real prefix '/usr' 05:20:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:21:01 INFO - Installing distribute.............................................................................................................................................................................................done. 05:21:03 INFO - Installing pip.................done. 05:21:03 INFO - Return code: 0 05:21:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:03 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 0xd89030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfba210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c220>, '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 0xfb82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb8740>, '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': 'e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887', '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 05:21:03 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 05:21:03 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 05:21:03 INFO - Using env: {'DISPLAY': ':0', 05:21:03 INFO - 'HOME': '/home/cltbld', 05:21:03 INFO - 'LANG': 'en_US.UTF-8', 05:21:03 INFO - 'LANGUAGE': 'en_US:en', 05:21:03 INFO - 'LOGNAME': 'cltbld', 05:21:03 INFO - 'MAIL': '/var/mail/cltbld', 05:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:03 INFO - 'MOZ_NO_REMOTE': '1', 05:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:03 INFO - 'NO_EM_RESTART': '1', 05:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:03 INFO - 'PWD': '/builds/slave/test', 05:21:03 INFO - 'SHELL': '/bin/bash', 05:21:03 INFO - 'SHLVL': '1', 05:21:03 INFO - 'TERM': 'linux', 05:21:03 INFO - 'TMOUT': '86400', 05:21:03 INFO - 'USER': 'cltbld', 05:21:03 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887', 05:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:03 INFO - '_': '/tools/buildbot/bin/python'} 05:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:03 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 05:21:03 INFO - Cleaning up... 05:21:03 INFO - Return code: 0 05:21:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:03 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 0xd89030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfba210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c220>, '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 0xfb82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb8740>, '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': 'e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887', '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 05:21:03 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 05:21:03 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 05:21:03 INFO - Using env: {'DISPLAY': ':0', 05:21:03 INFO - 'HOME': '/home/cltbld', 05:21:03 INFO - 'LANG': 'en_US.UTF-8', 05:21:03 INFO - 'LANGUAGE': 'en_US:en', 05:21:03 INFO - 'LOGNAME': 'cltbld', 05:21:03 INFO - 'MAIL': '/var/mail/cltbld', 05:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:03 INFO - 'MOZ_NO_REMOTE': '1', 05:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:03 INFO - 'NO_EM_RESTART': '1', 05:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:03 INFO - 'PWD': '/builds/slave/test', 05:21:03 INFO - 'SHELL': '/bin/bash', 05:21:03 INFO - 'SHLVL': '1', 05:21:03 INFO - 'TERM': 'linux', 05:21:03 INFO - 'TMOUT': '86400', 05:21:03 INFO - 'USER': 'cltbld', 05:21:03 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887', 05:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:03 INFO - '_': '/tools/buildbot/bin/python'} 05:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:03 INFO - Downloading/unpacking psutil>=0.7.1 05:21:03 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 05:21:03 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 05:21:03 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 05:21:03 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 05:21:03 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 05:21:03 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 05:21:05 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:21:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:21:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:05 INFO - Installing collected packages: psutil 05:21:05 INFO - Running setup.py install for psutil 05:21:05 INFO - building 'psutil._psutil_linux' extension 05:21:05 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 05:21:06 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 05:21:06 INFO - building 'psutil._psutil_posix' extension 05:21:06 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 05:21:07 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 05:21:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:07 INFO - Successfully installed psutil 05:21:07 INFO - Cleaning up... 05:21:07 INFO - Return code: 0 05:21:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:07 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 0xd89030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfba210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c220>, '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 0xfb82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb8740>, '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': 'e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887', '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 05:21:07 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 05:21:07 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 05:21:07 INFO - Using env: {'DISPLAY': ':0', 05:21:07 INFO - 'HOME': '/home/cltbld', 05:21:07 INFO - 'LANG': 'en_US.UTF-8', 05:21:07 INFO - 'LANGUAGE': 'en_US:en', 05:21:07 INFO - 'LOGNAME': 'cltbld', 05:21:07 INFO - 'MAIL': '/var/mail/cltbld', 05:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:07 INFO - 'MOZ_NO_REMOTE': '1', 05:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:07 INFO - 'NO_EM_RESTART': '1', 05:21:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:07 INFO - 'PWD': '/builds/slave/test', 05:21:07 INFO - 'SHELL': '/bin/bash', 05:21:07 INFO - 'SHLVL': '1', 05:21:07 INFO - 'TERM': 'linux', 05:21:07 INFO - 'TMOUT': '86400', 05:21:07 INFO - 'USER': 'cltbld', 05:21:07 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887', 05:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:07 INFO - '_': '/tools/buildbot/bin/python'} 05:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:21:07 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 05:21:07 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 05:21:07 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 05:21:07 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 05:21:07 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 05:21:07 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 05:21:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:21:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:21:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:21:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:21:09 INFO - Installing collected packages: mozsystemmonitor 05:21:09 INFO - Running setup.py install for mozsystemmonitor 05:21:09 INFO - Successfully installed mozsystemmonitor 05:21:09 INFO - Cleaning up... 05:21:09 INFO - Return code: 0 05:21:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:21:09 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')]} 05:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:09 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')]} 05:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:09 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 0xd89030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfba210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c220>, '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 0xfb82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb8740>, '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': 'e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887', '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 05:21:09 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 05:21:09 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 05:21:09 INFO - Using env: {'DISPLAY': ':0', 05:21:09 INFO - 'HOME': '/home/cltbld', 05:21:09 INFO - 'LANG': 'en_US.UTF-8', 05:21:09 INFO - 'LANGUAGE': 'en_US:en', 05:21:09 INFO - 'LOGNAME': 'cltbld', 05:21:09 INFO - 'MAIL': '/var/mail/cltbld', 05:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:09 INFO - 'MOZ_NO_REMOTE': '1', 05:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:09 INFO - 'NO_EM_RESTART': '1', 05:21:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:09 INFO - 'PWD': '/builds/slave/test', 05:21:09 INFO - 'SHELL': '/bin/bash', 05:21:09 INFO - 'SHLVL': '1', 05:21:09 INFO - 'TERM': 'linux', 05:21:09 INFO - 'TMOUT': '86400', 05:21:09 INFO - 'USER': 'cltbld', 05:21:09 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887', 05:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:09 INFO - '_': '/tools/buildbot/bin/python'} 05:21:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:09 INFO - Downloading/unpacking blobuploader==1.2.4 05:21:09 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 05:21:09 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 05:21:09 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 05:21:09 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 05:21:09 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 05:21:09 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 05:21:11 INFO - Downloading blobuploader-1.2.4.tar.gz 05:21:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:21:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:21:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:21: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 05:21: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 05:21: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 05:21: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 05:21: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 05:21: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 05:21:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:21:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:21:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:21:12 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 05:21:12 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 05:21:12 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 05:21:12 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 05:21:12 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 05:21:12 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 05:21:12 INFO - Downloading docopt-0.6.1.tar.gz 05:21:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:21:12 INFO - Installing collected packages: blobuploader, requests, docopt 05:21:12 INFO - Running setup.py install for blobuploader 05:21:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:21:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:21:12 INFO - Running setup.py install for requests 05:21:12 INFO - Running setup.py install for docopt 05:21:12 INFO - Successfully installed blobuploader requests docopt 05:21:12 INFO - Cleaning up... 05:21:12 INFO - Return code: 0 05:21:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:12 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')]} 05:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:12 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')]} 05:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:12 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 0xd89030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfba210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c220>, '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 0xfb82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb8740>, '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': 'e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887', '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 05:21:12 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 05:21:12 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 05:21:12 INFO - Using env: {'DISPLAY': ':0', 05:21:12 INFO - 'HOME': '/home/cltbld', 05:21:12 INFO - 'LANG': 'en_US.UTF-8', 05:21:12 INFO - 'LANGUAGE': 'en_US:en', 05:21:12 INFO - 'LOGNAME': 'cltbld', 05:21:12 INFO - 'MAIL': '/var/mail/cltbld', 05:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:12 INFO - 'MOZ_NO_REMOTE': '1', 05:21:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:12 INFO - 'NO_EM_RESTART': '1', 05:21:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:12 INFO - 'PWD': '/builds/slave/test', 05:21:12 INFO - 'SHELL': '/bin/bash', 05:21:12 INFO - 'SHLVL': '1', 05:21:12 INFO - 'TERM': 'linux', 05:21:12 INFO - 'TMOUT': '86400', 05:21:12 INFO - 'USER': 'cltbld', 05:21:12 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887', 05:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:12 INFO - '_': '/tools/buildbot/bin/python'} 05:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:13 INFO - Running setup.py (path:/tmp/pip-_41ZGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:13 INFO - Running setup.py (path:/tmp/pip-JlAXyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:13 INFO - Running setup.py (path:/tmp/pip-QH1olY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:13 INFO - Running setup.py (path:/tmp/pip-QrFm2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:13 INFO - Running setup.py (path:/tmp/pip-McOUwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:13 INFO - Running setup.py (path:/tmp/pip-K1Xbmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:13 INFO - Running setup.py (path:/tmp/pip-WXYkTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:13 INFO - Running setup.py (path:/tmp/pip-L0GYj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:13 INFO - Running setup.py (path:/tmp/pip-liYdOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:13 INFO - Running setup.py (path:/tmp/pip-qJTF3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:13 INFO - Running setup.py (path:/tmp/pip-0rJlQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:13 INFO - Running setup.py (path:/tmp/pip-ye_uR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:13 INFO - Running setup.py (path:/tmp/pip-i6jOab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:14 INFO - Running setup.py (path:/tmp/pip-NOPb_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:14 INFO - Running setup.py (path:/tmp/pip-jRgVMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:14 INFO - Running setup.py (path:/tmp/pip-_S1gHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:14 INFO - Running setup.py (path:/tmp/pip-8rRps3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:21:14 INFO - Running setup.py install for manifestparser 05:21:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:21:14 INFO - Running setup.py install for mozcrash 05:21:14 INFO - Running setup.py install for mozdebug 05:21:14 INFO - Running setup.py install for mozdevice 05:21:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:21:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:21:14 INFO - Running setup.py install for mozfile 05:21:14 INFO - Running setup.py install for mozhttpd 05:21:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:21:14 INFO - Running setup.py install for mozinfo 05:21:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Running setup.py install for mozInstall 05:21:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Running setup.py install for mozleak 05:21:15 INFO - Running setup.py install for mozlog 05:21:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Running setup.py install for moznetwork 05:21:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Running setup.py install for mozprocess 05:21:15 INFO - Running setup.py install for mozprofile 05:21:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Running setup.py install for mozrunner 05:21:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Running setup.py install for mozscreenshot 05:21:15 INFO - Running setup.py install for moztest 05:21:16 INFO - Running setup.py install for mozversion 05:21:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:21:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:21:16 INFO - Cleaning up... 05:21:16 INFO - Return code: 0 05:21:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21: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')]} 05:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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')]} 05:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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', '-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 0xd89030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfba210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c220>, '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 0xfb82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb8740>, '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': 'e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887', '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 05:21:16 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 05:21:16 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 05:21:16 INFO - Using env: {'DISPLAY': ':0', 05:21:16 INFO - 'HOME': '/home/cltbld', 05:21:16 INFO - 'LANG': 'en_US.UTF-8', 05:21:16 INFO - 'LANGUAGE': 'en_US:en', 05:21:16 INFO - 'LOGNAME': 'cltbld', 05:21:16 INFO - 'MAIL': '/var/mail/cltbld', 05:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:16 INFO - 'MOZ_NO_REMOTE': '1', 05:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:16 INFO - 'NO_EM_RESTART': '1', 05:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:16 INFO - 'PWD': '/builds/slave/test', 05:21:16 INFO - 'SHELL': '/bin/bash', 05:21:16 INFO - 'SHLVL': '1', 05:21:16 INFO - 'TERM': 'linux', 05:21:16 INFO - 'TMOUT': '86400', 05:21:16 INFO - 'USER': 'cltbld', 05:21:16 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887', 05:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:16 INFO - '_': '/tools/buildbot/bin/python'} 05:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:16 INFO - Running setup.py (path:/tmp/pip-NLX5BC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:16 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)) 05:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:16 INFO - Running setup.py (path:/tmp/pip-rthnGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:16 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)) 05:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:16 INFO - Running setup.py (path:/tmp/pip-smwCQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:16 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)) 05:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:16 INFO - Running setup.py (path:/tmp/pip-ZtrnnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:16 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)) 05:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:16 INFO - Running setup.py (path:/tmp/pip-8p1V_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:16 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)) 05:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:16 INFO - Running setup.py (path:/tmp/pip-9dfOXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:16 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)) 05:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:16 INFO - Running setup.py (path:/tmp/pip-98hHaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:16 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)) 05:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:16 INFO - Running setup.py (path:/tmp/pip-ayb0Wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:16 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)) 05:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:16 INFO - Running setup.py (path:/tmp/pip-O06EBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:16 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)) 05:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:16 INFO - Running setup.py (path:/tmp/pip-dyLlzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:17 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)) 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:17 INFO - Running setup.py (path:/tmp/pip-Z76zSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:17 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)) 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:17 INFO - Running setup.py (path:/tmp/pip-UDFWnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:17 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)) 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:17 INFO - Running setup.py (path:/tmp/pip-8JwaF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:17 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)) 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:17 INFO - Running setup.py (path:/tmp/pip-PTsKVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:17 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)) 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:17 INFO - Running setup.py (path:/tmp/pip-5D4zKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:17 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)) 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:17 INFO - Running setup.py (path:/tmp/pip-7gaiBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:17 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)) 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:17 INFO - Running setup.py (path:/tmp/pip-13fs4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:17 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)) 05:21:17 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)) 05:21:17 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)) 05:21:17 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)) 05:21:17 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)) 05:21:17 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)) 05:21:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:21:17 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 05:21:17 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 05:21:17 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 05:21:17 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 05:21:17 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 05:21:17 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 05:21:19 INFO - Downloading blessings-1.5.1.tar.gz 05:21:19 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 05:21:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:21:19 INFO - Installing collected packages: blessings 05:21:19 INFO - Running setup.py install for blessings 05:21:19 INFO - Successfully installed blessings 05:21:19 INFO - Cleaning up... 05:21:19 INFO - Return code: 0 05:21:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:21:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:19 INFO - Reading from file tmpfile_stdout 05:21:19 INFO - Current package versions: 05:21:19 INFO - argparse == 1.2.1 05:21:19 INFO - blessings == 1.5.1 05:21:19 INFO - blobuploader == 1.2.4 05:21:19 INFO - docopt == 0.6.1 05:21:19 INFO - manifestparser == 1.1 05:21:19 INFO - mozInstall == 1.12 05:21:19 INFO - mozcrash == 0.16 05:21:19 INFO - mozdebug == 0.1 05:21:19 INFO - mozdevice == 0.47 05:21:19 INFO - mozfile == 1.2 05:21:19 INFO - mozhttpd == 0.7 05:21:19 INFO - mozinfo == 0.9 05:21:19 INFO - mozleak == 0.1 05:21:19 INFO - mozlog == 3.1 05:21:19 INFO - moznetwork == 0.27 05:21:19 INFO - mozprocess == 0.22 05:21:19 INFO - mozprofile == 0.27 05:21:19 INFO - mozrunner == 6.11 05:21:19 INFO - mozscreenshot == 0.1 05:21:19 INFO - mozsystemmonitor == 0.0 05:21:19 INFO - moztest == 0.7 05:21:19 INFO - mozversion == 1.4 05:21:19 INFO - psutil == 3.1.1 05:21:19 INFO - requests == 1.2.3 05:21:19 INFO - wsgiref == 0.1.2 05:21:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21: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')]} 05:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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')]} 05:21:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:19 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 0xd89030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfba210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c220>, '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 0xfb82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb8740>, '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': 'e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887', '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 05:21:19 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 05:21:19 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 05:21:19 INFO - Using env: {'DISPLAY': ':0', 05:21:19 INFO - 'HOME': '/home/cltbld', 05:21:19 INFO - 'LANG': 'en_US.UTF-8', 05:21:19 INFO - 'LANGUAGE': 'en_US:en', 05:21:19 INFO - 'LOGNAME': 'cltbld', 05:21:19 INFO - 'MAIL': '/var/mail/cltbld', 05:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:19 INFO - 'MOZ_NO_REMOTE': '1', 05:21:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:19 INFO - 'NO_EM_RESTART': '1', 05:21:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:19 INFO - 'PWD': '/builds/slave/test', 05:21:19 INFO - 'SHELL': '/bin/bash', 05:21:19 INFO - 'SHLVL': '1', 05:21:19 INFO - 'TERM': 'linux', 05:21:19 INFO - 'TMOUT': '86400', 05:21:19 INFO - 'USER': 'cltbld', 05:21:19 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887', 05:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:19 INFO - '_': '/tools/buildbot/bin/python'} 05:21:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:19 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)) 05:21:19 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)) 05:21:19 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)) 05:21:19 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)) 05:21:19 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)) 05:21:19 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)) 05:21:19 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)) 05:21:19 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)) 05:21:19 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)) 05:21:19 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)) 05:21:19 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)) 05:21:19 INFO - Cleaning up... 05:21:19 INFO - Return code: 0 05:21:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:21: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')]} 05:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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')]} 05:21:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:19 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 0xd89030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfba210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c220>, '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 0xfb82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb8740>, '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': 'e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887', '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 05:21:19 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 05:21:19 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 05:21:19 INFO - Using env: {'DISPLAY': ':0', 05:21:19 INFO - 'HOME': '/home/cltbld', 05:21:19 INFO - 'LANG': 'en_US.UTF-8', 05:21:19 INFO - 'LANGUAGE': 'en_US:en', 05:21:19 INFO - 'LOGNAME': 'cltbld', 05:21:19 INFO - 'MAIL': '/var/mail/cltbld', 05:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:19 INFO - 'MOZ_NO_REMOTE': '1', 05:21:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:19 INFO - 'NO_EM_RESTART': '1', 05:21:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:19 INFO - 'PWD': '/builds/slave/test', 05:21:19 INFO - 'SHELL': '/bin/bash', 05:21:19 INFO - 'SHLVL': '1', 05:21:19 INFO - 'TERM': 'linux', 05:21:19 INFO - 'TMOUT': '86400', 05:21:19 INFO - 'USER': 'cltbld', 05:21:19 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887', 05:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:19 INFO - '_': '/tools/buildbot/bin/python'} 05:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:20 INFO - Downloading/unpacking jsonschema 05:21:20 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 05:21:20 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 05:21:20 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 05:21:20 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 05:21:20 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 05:21:20 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 05:21:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:21:21 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 05:21:21 INFO - Downloading/unpacking functools32 (from jsonschema) 05:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:22 INFO - Downloading functools32-3.2.3-2.tar.gz 05:21:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:21:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:21:22 INFO - warning: no files found matching '*.txt' 05:21:22 INFO - no previously-included directories found matching 'build' 05:21:22 INFO - no previously-included directories found matching 'dist' 05:21:22 INFO - no previously-included directories found matching '.git*' 05:21:22 INFO - Installing collected packages: jsonschema, functools32 05:21:22 INFO - Running setup.py install for functools32 05:21:22 INFO - warning: no files found matching '*.txt' 05:21:22 INFO - no previously-included directories found matching 'build' 05:21:22 INFO - no previously-included directories found matching 'dist' 05:21:22 INFO - no previously-included directories found matching '.git*' 05:21:22 INFO - Successfully installed jsonschema functools32 05:21:22 INFO - Cleaning up... 05:21:22 INFO - Return code: 0 05:21:22 INFO - Running post-action listener: _resource_record_post_action 05:21:22 INFO - Running post-action listener: _start_resource_monitoring 05:21:22 INFO - Starting resource monitoring. 05:21:22 INFO - ##### 05:21:22 INFO - ##### Running install step. 05:21:22 INFO - ##### 05:21:22 INFO - Running pre-action listener: _resource_record_pre_action 05:21:22 INFO - Running main action method: install 05:21:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:22 INFO - Reading from file tmpfile_stdout 05:21:22 INFO - Detecting whether we're running mozinstall >=1.0... 05:21:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:21:22 INFO - Reading from file tmpfile_stdout 05:21:22 INFO - Output received: 05:21:22 INFO - Usage: mozinstall [options] installer 05:21:22 INFO - Options: 05:21:22 INFO - -h, --help show this help message and exit 05:21:22 INFO - -d DEST, --destination=DEST 05:21:22 INFO - Directory to install application into. [default: 05:21:22 INFO - "/builds/slave/test"] 05:21:22 INFO - --app=APP Application being installed. [default: firefox] 05:21:22 INFO - mkdir: /builds/slave/test/build/application 05:21:22 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'] 05:21:22 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 05:21:36 INFO - Reading from file tmpfile_stdout 05:21:36 INFO - Output received: 05:21:36 INFO - /builds/slave/test/build/application/firefox/firefox 05:21:36 INFO - Running post-action listener: _resource_record_post_action 05:21:36 INFO - ##### 05:21:36 INFO - ##### Running run-tests step. 05:21:36 INFO - ##### 05:21:36 INFO - Running pre-action listener: _resource_record_pre_action 05:21:36 INFO - Running main action method: run_tests 05:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:21:36 INFO - Python 2.7.3 05:21:36 INFO - Return code: 0 05:21:36 INFO - grabbing minidump binary from tooltool 05:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:36 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 0x104c220>, '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 0xfb82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb8740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:21:36 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 05:21:36 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 05:21:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:21:37 INFO - Return code: 0 05:21:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:21:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:21:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:21:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:21:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:21:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] in /builds/slave/test/build 05:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost 05:21:37 INFO - Using env: {'DISPLAY': ':0', 05:21:37 INFO - 'HOME': '/home/cltbld', 05:21:37 INFO - 'LANG': 'en_US.UTF-8', 05:21:37 INFO - 'LANGUAGE': 'en_US:en', 05:21:37 INFO - 'LOGNAME': 'cltbld', 05:21:37 INFO - 'MAIL': '/var/mail/cltbld', 05:21:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:21:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:37 INFO - 'MOZ_NO_REMOTE': '1', 05:21:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:37 INFO - 'NO_EM_RESTART': '1', 05:21:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:37 INFO - 'PWD': '/builds/slave/test', 05:21:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:21:37 INFO - 'SHELL': '/bin/bash', 05:21:37 INFO - 'SHLVL': '1', 05:21:37 INFO - 'TERM': 'linux', 05:21:37 INFO - 'TMOUT': '86400', 05:21:37 INFO - 'USER': 'cltbld', 05:21:37 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887', 05:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:37 INFO - '_': '/tools/buildbot/bin/python'} 05:21:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] with output_timeout 3600 05:21:37 INFO - mozversion INFO | application_buildid: 20151126044312 05:21:37 INFO - mozversion INFO | application_changeset: 4aad8e3db7e990ccd2dfc6e7840632559272b22b 05:21:37 INFO - mozversion INFO | application_display_name: Nightly 05:21:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:21:37 INFO - mozversion INFO | application_name: Firefox 05:21:37 INFO - mozversion INFO | application_remotingname: firefox 05:21:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 05:21:37 INFO - mozversion INFO | application_vendor: Mozilla 05:21:37 INFO - mozversion INFO | application_version: 45.0a1 05:21:37 INFO - mozversion INFO | platform_buildid: 20151126044312 05:21:37 INFO - mozversion INFO | platform_changeset: 4aad8e3db7e990ccd2dfc6e7840632559272b22b 05:21:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 05:21:37 INFO - mozversion INFO | platform_version: 45.0a1 05:21:37 INFO - 2015-11-26 05:21:37,629 DEBUG : using testdate: 1448544097 05:21:37 INFO - 2015-11-26 05:21:37,629 DEBUG : actual date: 1448544097 05:21:37 INFO - 2015-11-26 05:21:37,637 INFO : starting webserver on 'localhost:42235' 05:21:37 INFO - 2015-11-26 05:21:37,638 INFO : Starting test suite talos-linux64-ix-023 05:21:37 INFO - 2015-11-26 05:21:37,638 INFO : Starting test dromaeo_css 05:21:37 INFO - 2015-11-26 05:21:37,638 DEBUG : operating with platform_type : linux_ 05:21:37 INFO - 2015-11-26 05:21:37,639 INFO : Initialising browser for dromaeo_css test... 05:21:37 INFO - 2015-11-26 05:21:37,693 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphkFB1N/profile http://localhost:42235/getInfo.html 05:21:43 INFO - 2015-11-26 05:21:43,868 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:21:43 INFO - 2015-11-26 05:21:43,868 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:21:43 INFO - 2015-11-26 05:21:43,869 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:21:43 INFO - 2015-11-26 05:21:43,869 DEBUG : BROWSER_OUTPUT: __metrics 05:21:44 INFO - 2015-11-26 05:21:44,050 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] 05:21:45 INFO - 2015-11-26 05:21:45,263 INFO : Browser initialized. 05:21:45 INFO - 2015-11-26 05:21:45,264 INFO : Running cycle 1/1 for dromaeo_css test... 05:21:45 INFO - 2015-11-26 05:21:45,264 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphkFB1N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:21:57 INFO - 2015-11-26 05:21:57,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 138772480 05:21:57 INFO - 2015-11-26 05:21:57,081 DEBUG : BROWSER_OUTPUT: 05:22:48 INFO - 2015-11-26 05:22:48,374 DEBUG : BROWSER_OUTPUT: 1448544168366 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] 05:25:00 INFO - 2015-11-26 05:25:00,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42235/tests/dromaeo/cssquery-ext.html) 05:25:01 INFO - 2015-11-26 05:25:01,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 246087680 05:25:01 INFO - 2015-11-26 05:25:01,818 DEBUG : BROWSER_OUTPUT: 05:28:04 INFO - 2015-11-26 05:28:04,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42235/tests/dromaeo/cssquery-ext.html (next: http://localhost:42235/tests/dromaeo/cssquery-jquery.html) 05:28:04 INFO - 2015-11-26 05:28:04,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 226492416 05:28:04 INFO - 2015-11-26 05:28:04,953 DEBUG : BROWSER_OUTPUT: 05:31:07 INFO - 2015-11-26 05:31:07,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42235/tests/dromaeo/cssquery-mootools.html) 05:31:07 INFO - 2015-11-26 05:31:07,683 DEBUG : BROWSER_OUTPUT: RSS: Main: 213389312 05:31:07 INFO - 2015-11-26 05:31:07,683 DEBUG : BROWSER_OUTPUT: 05:34:09 INFO - 2015-11-26 05:34:09,602 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42235/tests/dromaeo/cssquery-prototype.html) 05:34:10 INFO - 2015-11-26 05:34:10,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 199245824 05:34:10 INFO - 2015-11-26 05:34:10,172 DEBUG : BROWSER_OUTPUT: 05:37:13 INFO - 2015-11-26 05:37:13,001 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42235/tests/dromaeo/cssquery-yui.html) 05:37:13 INFO - 2015-11-26 05:37:13,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 204492800 05:37:13 INFO - 2015-11-26 05:37:13,594 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-11-26 05:40:16,022 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42235/tests/dromaeo/cssquery-yui.html (next: http://localhost:42235/tests/dromaeo/cssquery-dojo.html) 05:40:16 INFO - 2015-11-26 05:40:16,272 DEBUG : BROWSER_OUTPUT: RSS: Main: 253411328 05:40:16 INFO - 2015-11-26 05:40:16,273 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-11-26 05:40:16,274 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:40:16 INFO - 2015-11-26 05:40:16,274 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:40:16 INFO - 2015-11-26 05:40:16,275 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:40:16 INFO - 2015-11-26 05:40:16,275 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:40:16 INFO - 2015-11-26 05:40:16,276 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2636.472705458908;2712.837229766214;2713.2674177971962;2732.453509298141;2745.6705195376553;4515.706479078865;4613.792379342929;4667.556582124701;4679.532046795319;4703.223968045273;4523.253663145585;4549.135664223803;4642.489326174118;4643.0481751240995;4649.9070018599605;4276.700630955826;4291.721038132527;4297;4317.525072242051;4331.913361732779;4080.5715399882884;4387.385765992748;4400.405945197405;4434.268345722952;4437.511873693891;4179.185058913528;4181.811818468176;4195.056112374722;4305.461817272841;4309.5690430956965;4301.37630043645;4302.440682711259;4310.913781724379;4314.61168494837;4355.259605867011;4271.1671224111315;4273.038566322583;4278.144371125787;4309.310510318334;4325.221460137174;4341.761203133827;4452.131834292314;4467.30756732707;4468.4414448193975;4596.241620132674;4970.13022721026;5023.171176755831;5025.648204625678;5029.19532874742;5073.061483625541;5056.646034777567;5058.367704036996;5060.165072763027;5065.290859279704;5068.087744206042;4492.505824359318;4564.360989461478;4603.539646035403;4604.355390245369;4605.585497305258;5156.355455568054;5161.509656582619;5162.6386152968935;5169.172932330809;5211.635185536976;4934.703917764946;4937.901241975141;4938.086454005948;4940.802367905316;4983.975080124576;4804.783784729696;4891.266310053449;4903.068417000758;4907.754612269372;5016.824411145592;4963;4999.075171093286;4999.525045120708;5002.474740152232;5008.774605142778;4962.652614317035;4971.080350135237;4973.229149481836;4974.228994505857;4999.825006124768;3963.4451176835264;4009.7393669411977;4042.130941847458;4077.510698716114;4206.726562773471;3638.6725194732603;3662.450632405107;3672.5042119314085;3674;3694.9815250923575;4336.371226172188;4343.3484977253665;4346.391505189276;4387.5393083726385;4389.648828093745;4798.95201047992;4909.852704418873;4931.457539670633;5062.341895553554;5063.974680126576;4219.472565929259;4233.957660423356;4264.530901600821;4311.267084595626;4335.956640433618;4432.689711720149;4455.353973673799;4469.865904022885;4475.507694153641;4512.300593408027;4527.90944181108;4636.188666983332;4639.4896561377545;4790.976045119683;4799.856004319876;4850.957044235506;4927.827526036572;4944.554990050912;4946.480619534897;4992.900141997067;4713.528647135259;4762.380890484214;4765.380500534909;4771.7375544344;4808.0383923216195;4691.272852707836;4774.188387974123;4777.211760059551;4939.580135688507;4976.377952755905;4867.123917694707;4977.0792403405485;4993.675411098412;4997.100521906092;5009.749512524287;4843.806247750051;4855.1260773061185;4856.8300109495995;4858.975705121452;4907.975460122677;4589.059242855274;4707.035057813072;4707.764611769467;4858.951410485991;4908.018396320679;4711.246200607886;4760.571548560646;4767.785449654843;4775;4831.178699621002;4885.804567817389;4897.926531101965;4928.088303663833;4936.950630493649;4950.529699678525;4599.632029437704;4689.507601701772;4708.081924024782;4820.373351464287;4878.707277563216 05:40:16 INFO - 2015-11-26 05:40:16,280 DEBUG : BROWSER_OUTPUT: |1;ext.html;493.2773486841776;498.1407072799424;570.9771609135634;576.5070864410928;579.9913001304981;20410;20516.48708782281;20705;20741.481462963435;36541.45187822185;40407.39388909161;40873;40941;40968.79515602425;40987.18025639485;7949.443538952261;8108.2297181767635;8112.634931428071;8113.43205975582;8115.675372985073;6677.565958212725;6833.6241506717115;8001.5199088054615;10310;10575.365478071302;10257.230707696915;10362.326448780843;10362.637307694233;10365.948170259138;10374.32566883154;6729.663516824139;10273.434961077137;10402.219833512441;10402.895971040343;10406.583736650562;6659.966700166517;10352.741181470523;10599.046085852311;10615;10627.04356607909;37006.25987480235;37642;37658.24683506342;37681.24637507235;37695;2757.3658058646624;2903.4483448144997;2905.2155917902046;3091.442723100609;3278.4754439289836;27796.861015694994;28149.437011259866;28212.294692632644;28345;28547.143585692254;3366.5239470277706;3449.275652113059;3462.255615042778;3539.50446937429;3575.4279315309427;230054;232032;232252.9999999983;232946;233414;46054.76972615116;46291;46302;46302.76848615735;46354;35325.646743532234;36172.81913590415;58717.11924321053;61090;61263.081053784226;12473.563425280072;12571.497140114476;12633.115681902362;12666.873331266754;12692.492300307884;10223.846642300372;10299.073083422529;10316.43259620713;10327.483625818679;10340.276180667432;19359.483267175176;19581.412557623295;19652.312169074015;19666.213351466067;19670.114844832016;7478.925210747823;7619.580923049175;7683.615819209017;7706.730264440717;7717.614119294013;774.5701135869647;780.2470615855613;818.8157664525553;854.4616891358529;915.688665853613;26439;26575.468490630465;26779.196624101307;26792.33019174536;26870;943.9622415103319;967.3373738988815;986.6398764450923;1005.3013155856755;1010.1161483701761;13280.136791108547;13440.193588384729;14980.475683351031;16145.354185832435;16287.674246515004;345425;346733;347780;349027;349310;47298.76350618225;48045;48173;48175.27737083947;48192;1016.5222345497605;1185.697647099984;1210.8244304575787;1211.6183402228446;1213.7815193265296;27401.45197096087;28261.57607635846;28323.433531328847;28561;30733.616987236077;24961;25556.488870222864;42094.57905420907;43556.34665479957;43595;247137;251244;253190;253557;254118;35324.82337588296;35668.286634267686;35904.64095359013;35914.820425897706;35953.46069809007;38916.80541597274;38981.99322517401;42567.57432425636;42615.147697045264;42835.57164428316;32601.18497037593;32657.836710816293;32814;32989.83505082459;33358.66489345722;35234.11914702153;35460.82269588635;35653.28693426169;36050.819745901106;36200.818995904854;35042.824785876925;35112;35269;35477.29045419129;35591.46612800758;31419.371612568077;32188.678113219506;32356.676433235367;32371.51442728408;32403;24257.393565160306;24497.51004979926;24690.876545617157;25302.367440813392;25429.61855572131 05:40:16 INFO - 2015-11-26 05:40:16,280 DEBUG : BROWSER_OUTPUT: |2;jquery.html;332.21762748726746;334.56673607678056;335.6039872949919;336.02217546938414;338.71886334342497;11150.052245559138;11549.480273387697;15057.698846023086;15444.845551544482;15523.844761552382;7660.080790305157;9499.905000949988;9818.263630227726;11702.531898724063;15066.3220155093;4545.454545454541;4630.166570017395;4649.163150632885;4659.697119687226;4664.183767840631;3194.2174167329035;4337.739735615857;4524.389207457;5226.947730522684;5228.424873263957;5170.327857378536;5189.169732842746;5195.792168313263;5200.68795872247;5215.087359712054;5036.697798132123;5156.278121063054;5160.741962901859;5163.302954101224;5174.301469301652;4985.675931064469;4989.600831933437;5017.573506251973;5018.322526458918;5052.115879721071;11682.24065435744;11971.102167337398;18207.08964551767;18338.908305458386;18355.357562485384;1794.97307540387;1807.9638407231914;1812.0215083854703;1837.5314294854861;1847.4919397165752;9027.864582031209;9084.818303633956;9283.071692830663;9351.205147562465;9366.391184572982;1646.9176541173013;1710.2731339180923;1748.6327871147075;1770.1060964213118;1815.473512681321;54832;55917.161242581395;56098;56657.43342566563;56867.431325687045;9714.75713107178;9801.31390802637;9834.459104749307;9837.409755414556;9862.457564834003;12462.750744985231;12491.562795302121;12501.749965000648;12502.687432814071;12506.124571279923;6176.81469555914;6391.392817682313;6645.435138013323;6832.59004459734;6928.861422771516;6350.809475715643;6370.904436433365;6424.26120996082;6437.420632143129;6508.056331831858;4102.138550904284;4128.277551428488;4150.377443383456;4207.579242075829;4234.640055595247;1440.5102265229873;1492.6790739990954;1494.1174120608111;1494.6473441535427;1706.334529533483;798.5568009754642;800.5756948817136;861.8491763941286;888.995435158267;919.5402298850574;14063.2968351582;14514.274286285643;14955.401783928739;15493.612659683598;15607.063576185465;618.2673531864755;791.1297572670017;801.2988634944423;808.1231863428246;830.2361827119065;7995.520268783892;8446.155384461505;8508.191721786421;8672.349573781992;8890.688825891062;483771;487513;492132;509635;511465;74101;74655;75079;75212;75377.6231118841;1045.153425725165;1054.99472502637;1061.543536279392;1063.1388575254068;1065.2383545764815;13402.664933376744;13679.726405471636;13931.442742290601;13990.860091398956;14272.14367137975;29261.268468288465;29492.852535737184;30362.696373035986;32310.35379292448;32904;39333.819985400485;39971.80014099911;40540.797296013334;41530;42951;8564;8911.019787823463;9055.728328150166;9109.453432794053;9122.087791220825;10608.840867387149;10729.785404292026;13196.868031319564;15364.385424582892;15794.210289485709;13375.331233438095;13521.729565408834;13522.729545409233;13542.390592423562;13555.525556605471;12931.676708082374;13469;13476;13613.910887129205;13950.372233249325;9365.531723413938;13684.931575342458;13880.403753568065;13901.86098139046;14001.579952601438;6992.601479703978;7181.856362872818;8387.622556984828;8526.872096918427;8527.872081918653;2349.8120150388268;9052.864207036768;11549.48027338755;13144.333761514525;13508.121972071784 05:40:16 INFO - 2015-11-26 05:40:16,281 DEBUG : BROWSER_OUTPUT: |3;mootools.html;948.6395169835462;1210.4492455932548;1261.9432125554351;1379.3379177994561;1662.1439958421415;5418.837434876955;6757.729690812368;6940.340667636567;6951.860962780741;6958.965205173967;6736.461083113351;6885.104936358266;6888.276730943241;6895.827604309895;6895.827604309895;2029.3100345882397;2061.907214175358;2065.7417822772154;2066.6693329067352;2073.170731707314;2070.285751415759;2092.602405542942;2099.3492017474555;2102.1381233694187;2113.2286715348864;2003.1586733571862;2056.4858785303672;2076.117649998752;2076.397844625057;2079.2722547108465;2012.4868158619531;2041.2447394464143;2044.5604195097976;2046.6827641715558;2047.170895787201;1999.3701983875033;2042.1320938601036;2054.1064636882857;2054.9486262843398;2057.8765274083453;5490.917636235459;5644.548436125141;6803.421709154678;6881.036654868322;6884.311568843075;3796.335641262768;3899.122697393064;3907.648311651965;3924.5879182685976;3939.3893946438347;2655.4290827472187;2668.5330067238156;2707.905223317194;2709.525832979221;2723.3463968647384;862.1163307609751;868.7089824908663;880.190224993008;883.3463237204487;888.506878682331;9056.184943355063;9121.224695900857;9132.08679132088;9133.680321188727;9133.954330228373;3849.0377405648587;3859;3887.475190849256;3905.7851818150275;3953.8616148435244;7949;8040;8040.39697022714;8047.994000749906;8070.394720395994;4047.1500984793524;4047.291723948297;4059.715819892638;4063.0248740302113;4066.1257829566784;3701.925961480755;3706.777593344408;3708.2398108387715;3710.7216958728204;3712.5173727415263;3192.265778870826;3193.664665210166;3206.3907857506997;3258.3809076275434;3258.462353711611;1040.843873418978;1044.566504900473;1045.5556388534842;1049.632628579991;1049.9370037797758;918.2791508665665;930.7580029192324;934.3366209990983;952.1668540027476;954.3176628710505;6269.310375858652;6336.1762970814425;6344.904826427607;6346.2067241594805;6351.777687780906;441.23225587478197;450.4234579737941;452.8482958208971;454.38884700079;457.90384019355645;4158.334666453353;5032.823851165192;5060.671056381323;5076.162433198481;5078.568321692697;6865.862682746317;8218;8274.544900030436;8353.37349698775;8414.537200454033;8077.434579579491;8176.67293308261;8180.345572354197;8210.220029097227;8229.094799572042;5934.554908381889;6010.639361638316;6037.969810151009;6039.305479869871;6045.21412216409;6323.494120470444;6330.873382532415;6340.968295158679;6348.809535713936;6352.809415717536;7101.8579628406105;7350.669219885011;7414.295641914009;7421.109466864011;7486.812829679302;7561.470697051153;7592.8481430369975;7600.1639819618695;7701.80745481345;7725.922740772745;5641.887162256814;5711.543076553949;5726.112452569859;5747.224124743107;5747.683877386784;6203;6279.937200628118;6287;6290.150829637941;6290.842728931813;6076.210092688099;6158.938410615837;6210.130581718653;6243.43809057187;6284.968575157095;5961.791337303347;6029.246344206974;6045.214122164267;6081.543884208613;6104.816855494342;5950.523958083257;5998.610090344114;6126.540509461719;6146.5390095742105;6150.938490615036;5714;5741.827745167651;5759.0209664356325;5761.567882408753;5761.942380576141;5552.194931734795;5816.883662326814;5838.357780644211;5844.824655260349;5846.386129456516 05:40:16 INFO - 2015-11-26 05:40:16,283 DEBUG : BROWSER_OUTPUT: |4;prototype.html;298.17703139335435;301.89282804604363;305.1577645697874;305.25213227592377;309.4908874900788;5317;5359.1425371940495;5389.191621256813;5395.37953135389;5414.187871819229;5048.949510504894;5169.457206993258;5177.456367081459;5338.1192103303;5341.759620817063;4140.7515549067;4156.376543518474;4165.604267594574;4169.603887630686;4178.039051018252;3898.9805050974705;4163.812628431712;4164.146349998243;4170.916581668364;4176.394422808691;3934.5081864766903;3982.1637456134245;4079.938800917989;4124.752514849119;4161.895952601179;4153.044799696087;4154.833806647731;4157.812898419578;4160.084781348099;4160.8959776005695;3645.908852278688;3652.2330310634798;3656.597774244831;3657.5062366580437;3660.871869484582;5164.948350516484;5186.222066689989;5190.558802501791;5197.974010129963;5198.740062996872;4549.954500454986;4698.295255711637;4720.457147428056;4727.45634252062;4787.066522028206;5582;5642.746076426571;5642.971785141089;5645.576581756343;5651.124075768222;3876.186000939806;3877;3877.5540812806607;3879.650831425157;3880.8835734927998;5886.587938844283;5891.587588868781;5928.555358348141;5929.64422134669;5939.4357536034;3824.541055073353;3941.3890846918775;3947.8026098695523;3951.940720889189;3958.782266975344;3999.560048394674;4001.1797581495725;4001.7398869073418;4005.939910901339;4013.4581831452965;4626.352310676508;4636.258198688193;4640.559146881041;4668.183067963161;4673.275642275453;5654.321481422256;5656.632318899258;5659.717014149276;5661.207430959669;5665.235193248941;1322.6494978830617;1322.8305578850693;1329.5745361484426;1405.7188562287583;1410.7037522120265;958.6740508227236;964.8697425847561;968.8692026576463;977.8435450327913;981.3670182732097;4866.416030076413;4868.050730107595;4868.464468908417;4879.39007624047;4879.902401951941;5721.313442386941;5758.366579676316;5806.590265040046;5813.360530341659;5816.94183058164;4905.362302900671;4930.33440485537;4934.210526315772;4938.308636790852;4943.085529177114;3077.1384012476096;3108.2384815720293;3147.244661281322;3150.480170771797;3151.5430262611794;5497.642653227527;5499.092649712753;5514.476124768141;5516.089845175501;5526.889462210734;5967.850803729942;5969.552283578749;5973.611715238496;5976.252968378953;5978.043513037893;5514.228008078872;5517.944820551743;5519.31008623922;5522.282103326542;5525.861853453695;5775.566832487496;5829.883402332014;5964.165016897551;5968.70156492165;5970.522358211246;5797.739101740516;5797.797077102281;5804.100364443518;5812.796552120655;5813.447722466359;5625.156226566048;5634.830955071355;5639.774409023593;5640.097584386478;5641.153826925994;3916.373380259145;4010.1779135276615;4070.5522392536204;4072.6538244249573;4075.0831063010587;5612.382637909908;5884.705764711833;5908.261467316585;5910.083936989773;5911.054231322968;5503.394626591152;5533.14236293359;5691.4877661010705;5694.231278777312;5696.772129114955;5644.322681278109;5680.602357834912;5683.3748287687495;5686.630369026;5687.175359572756;5537.9169312459535;5555.555555555627;5559.221708960829;5559.360673522597;5566.165075238747;5538.169274608841;5644.6330988485615;5702.743376547983;5710.428957104256;5712.428757124254;5552.972235138798;5554.222408862844;5559.138333558305;5591.412901645269;5630.943690563042 05:40:16 INFO - 2015-11-26 05:40:16,283 DEBUG : BROWSER_OUTPUT: |5;yui.html;718.8346680263543;720.7729565186966;754.4077898849403;767.5433117295207;771.8610650082985;11091;11466.19736618436;11481.885181148185;11538.711532211679;11552.075833933275;8899.33255005874;11505.367204803733;11602.361870097142;11608.94195529021;11609.709757256072;764.5374548398222;772.6947855597036;777.1063277231173;777.2188950105136;778.0119248554332;768.06679883941;774.9263819937097;775.3370867907942;776.3827756933223;779.4349096904728;795.5823192823756;812.0985705866483;814.6822739131743;814.7515007922581;815.351795322717;804.0110663883397;805.4885147931047;807.3339494916688;808.2442915873677;809.3161278719502;591.857954091015;596.5436441122545;596.7076132694991;596.964182149068;597.2444857255575;10345.120664743506;10500.632477863315;10545.36727796327;10546.103581195608;10552.947235263775;10741.62404315853;10919.945400272947;10971.451427428598;11014;11197.552097916156;8841.204291613785;8848.955755221246;8858;8919.910800892038;8980.46117232968;3166.493361062242;3203.0711093782775;3237.3363460490777;3239.4492936200904;3246.253361726816;38253.23493530114;38693.80653096745;38741.80629096865;38780.22439551221;41123.588764112275;8340.708075217459;8347;8425.915740842636;8494.74515764528;8724.389292749447;15610.3755849767;15660.060396376253;15697.607559810867;15711.292991815395;15768.132752698482;6094.146819445281;6157.907631385533;6200.255969283625;6255.093011513396;6389.8722025560155;3551.0057183988524;3644.21649345392;3708.4066549352515;3747.45661879026;3750.7937063461227;2671.866406679658;2715.714849940767;2716.660417447819;2716.8369897806197;2717.4972630063503;450.79263538772534;450.9932351014737;456.24946962247583;457.2455448509985;458.08611819419804;501.0280056690082;582.6999095465839;588.8910551547978;596.4035964035965;608.2062907905226;7387.372073373716;8604.526751028754;8706.434081784664;8797.736067917973;8817.559122043873;469.91071696377577;506.8479456163136;561.8763871948165;573.6443405088871;590.2739630254811;3494.7029502492064;3536.91157721059;3950.4469374287623;3977.2840888639744;4014.979925100414;55132;55525;56080.15879761807;56953;57175.42824571784;41403.58596414058;43829.780851095544;44697.329540056926;45108.09783804305;48146.5185348149;40759.796201018806;42717.786411068366;42818;42991.35512967308;42992.06535705901;7242.275772422716;7559.659815308214;7681.462297639112;8260.628271727666;8375.581220938806;29825.25436864096;30035.249118772204;30062.849685752306;30645.846770766002;31597.526037109;36292;37092.81453592823;39137.608623913395;39487.21025579415;39815;10185.439800811026;10429.68710938673;10455.947720261654;10522;10749.14006879432;11104.500297486471;11338.659840204808;11350.54597816078;11434.599789007345;11502.48238829238;10256.17950563968;10365.63720269787;10396.16830653561;10524.894751052698;10578.682639520826;9990.500474976077;10289.176865850564;10576.20678449104;10803.459827008775;11115.166362522681;9778.364406313567;9935.900640993787;9981.550830212513;10159.898401016191;10256.692299231036;8805.924220014229;8817.16236957488;9052.140046695553;9107.590158442754;9287.582058807235;8206.425550211428;8652.740417787476;8781.868271975798;8794.164554367326;8815.471071735716 05:40:16 INFO - 2015-11-26 05:40:16,284 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:40:16 INFO - 2015-11-26 05:40:16,284 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:40:16 INFO - 2015-11-26 05:40:16,284 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,877 05:40:16 INFO - 2015-11-26 05:40:16,284 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:40:16 INFO - 2015-11-26 05:40:16,285 DEBUG : BROWSER_OUTPUT: __startTimestamp1448545216273__endTimestamp 05:40:16 INFO - 2015-11-26 05:40:16,285 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-11-26 05:40:16,285 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:40:16 INFO - 2015-11-26 05:40:16,285 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:40:16 INFO - 2015-11-26 05:40:16,285 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-11-26 05:40:16,285 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4592.94 Median:4707.04 stddev:476.72 (10.1%) stddev-sans-first:452.80 05:40:16 INFO - 2015-11-26 05:40:16,285 DEBUG : BROWSER_OUTPUT: Values: 2636.5 2712.8 2713.3 2732.5 2745.7 4515.7 4613.8 4667.6 4679.5 4703.2 4523.3 4549.1 4642.5 4643.0 4649.9 4276.7 4291.7 4297.0 4317.5 4331.9 4080.6 4387.4 4400.4 4434.3 4437.5 4179.2 4181.8 4195.1 4305.5 4309.6 4301.4 4302.4 4310.9 4314.6 4355.3 4271.2 4273.0 4278.1 4309.3 4325.2 4341.8 4452.1 4467.3 4468.4 4596.2 4970.1 5023.2 5025.6 5029.2 5073.1 5056.6 5058.4 5060.2 5065.3 5068.1 4492.5 4564.4 4603.5 4604.4 4605.6 5156.4 5161.5 5162.6 5169.2 5211.6 4934.7 4937.9 4938.1 4940.8 4984.0 4804.8 4891.3 4903.1 4907.8 5016.8 4963.0 4999.1 4999.5 5002.5 5008.8 4962.7 4971.1 4973.2 4974.2 4999.8 3963.4 4009.7 4042.1 4077.5 4206.7 3638.7 3662.5 3672.5 3674.0 3695.0 4336.4 4343.3 4346.4 4387.5 4389.6 4799.0 4909.9 4931.5 5062.3 5064.0 4219.5 4234.0 4264.5 4311.3 4336.0 4432.7 4455.4 4469.9 4475.5 4512.3 4527.9 4636.2 4639.5 4791.0 4799.9 4851.0 4927.8 4944.6 4946.5 4992.9 4713.5 4762.4 4765.4 4771.7 4808.0 4691.3 4774.2 4777.2 4939.6 4976.4 4867.1 4977.1 4993.7 4997.1 5009.7 4843.8 4855.1 4856.8 4859.0 4908.0 4589.1 4707.0 4707.8 4859.0 4908.0 4711.2 4760.6 4767.8 4775.0 4831.2 4885.8 4897.9 4928.1 4937.0 4950.5 4599.6 4689.5 4708.1 4820.4 4878.7 05:40:16 INFO - 2015-11-26 05:40:16,286 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-11-26 05:40:16,286 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43254.24 Median:32901.92 stddev:73800.45 (224.3%) stddev-sans-first:73937.64 05:40:16 INFO - 2015-11-26 05:40:16,286 DEBUG : BROWSER_OUTPUT: Values: 493.3 498.1 571.0 576.5 580.0 20410.0 20516.5 20705.0 20741.5 36541.5 40407.4 40873.0 40941.0 40968.8 40987.2 7949.4 8108.2 8112.6 8113.4 8115.7 6677.6 6833.6 8001.5 10310.0 10575.4 10257.2 10362.3 10362.6 10365.9 10374.3 6729.7 10273.4 10402.2 10402.9 10406.6 6660.0 10352.7 10599.0 10615.0 10627.0 37006.3 37642.0 37658.2 37681.2 37695.0 2757.4 2903.4 2905.2 3091.4 3278.5 27796.9 28149.4 28212.3 28345.0 28547.1 3366.5 3449.3 3462.3 3539.5 3575.4 230054.0 232032.0 232253.0 232946.0 233414.0 46054.8 46291.0 46302.0 46302.8 46354.0 35325.6 36172.8 58717.1 61090.0 61263.1 12473.6 12571.5 12633.1 12666.9 12692.5 10223.8 10299.1 10316.4 10327.5 10340.3 19359.5 19581.4 19652.3 19666.2 19670.1 7478.9 7619.6 7683.6 7706.7 7717.6 774.6 780.2 818.8 854.5 915.7 26439.0 26575.5 26779.2 26792.3 26870.0 944.0 967.3 986.6 1005.3 1010.1 13280.1 13440.2 14980.5 16145.4 16287.7 345425.0 346733.0 347780.0 349027.0 349310.0 47298.8 48045.0 48173.0 48175.3 48192.0 1016.5 1185.7 1210.8 1211.6 1213.8 27401.5 28261.6 28323.4 28561.0 30733.6 24961.0 25556.5 42094.6 43556.3 43595.0 247137.0 251244.0 253190.0 253557.0 254118.0 35324.8 35668.3 35904.6 35914.8 35953.5 38916.8 38982.0 42567.6 42615.1 42835.6 32601.2 32657.8 32814.0 32989.8 33358.7 35234.1 35460.8 35653.3 36050.8 36200.8 35042.8 35112.0 35269.0 35477.3 35591.5 31419.4 32188.7 32356.7 32371.5 32403.0 24257.4 24497.5 24690.9 25302.4 25429.6 05:40:16 INFO - 2015-11-26 05:40:16,286 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-11-26 05:40:16,286 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26062.79 Median:23644.37 stddev:81290.65 (343.8%) stddev-sans-first:81495.73 05:40:16 INFO - 2015-11-26 05:40:16,287 DEBUG : BROWSER_OUTPUT: Values: 332.2 334.6 335.6 336.0 338.7 11150.1 11549.5 15057.7 15444.8 15523.8 7660.1 9499.9 9818.3 11702.5 15066.3 4545.5 4630.2 4649.2 4659.7 4664.2 3194.2 4337.7 4524.4 5226.9 5228.4 5170.3 5189.2 5195.8 5200.7 5215.1 5036.7 5156.3 5160.7 5163.3 5174.3 4985.7 4989.6 5017.6 5018.3 5052.1 11682.2 11971.1 18207.1 18338.9 18355.4 1795.0 1808.0 1812.0 1837.5 1847.5 9027.9 9084.8 9283.1 9351.2 9366.4 1646.9 1710.3 1748.6 1770.1 1815.5 54832.0 55917.2 56098.0 56657.4 56867.4 9714.8 9801.3 9834.5 9837.4 9862.5 12462.8 12491.6 12501.7 12502.7 12506.1 6176.8 6391.4 6645.4 6832.6 6928.9 6350.8 6370.9 6424.3 6437.4 6508.1 4102.1 4128.3 4150.4 4207.6 4234.6 1440.5 1492.7 1494.1 1494.6 1706.3 798.6 800.6 861.8 889.0 919.5 14063.3 14514.3 14955.4 15493.6 15607.1 618.3 791.1 801.3 808.1 830.2 7995.5 8446.2 8508.2 8672.3 8890.7 483771.0 487513.0 492132.0 509635.0 511465.0 74101.0 74655.0 75079.0 75212.0 75377.6 1045.2 1055.0 1061.5 1063.1 1065.2 13402.7 13679.7 13931.4 13990.9 14272.1 29261.3 29492.9 30362.7 32310.4 32904.0 39333.8 39971.8 40540.8 41530.0 42951.0 8564.0 8911.0 9055.7 9109.5 9122.1 10608.8 10729.8 13196.9 15364.4 15794.2 13375.3 13521.7 13522.7 13542.4 13555.5 12931.7 13469.0 13476.0 13613.9 13950.4 9365.5 13684.9 13880.4 13901.9 14001.6 6992.6 7181.9 8387.6 8526.9 8527.9 2349.8 9052.9 11549.5 13144.3 13508.1 05:40:16 INFO - 2015-11-26 05:40:16,287 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-11-26 05:40:16,288 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4719.31 Median:5845.61 stddev:2456.88 (42.0%) stddev-sans-first:2447.41 05:40:16 INFO - 2015-11-26 05:40:16,288 DEBUG : BROWSER_OUTPUT: Values: 948.6 1210.4 1261.9 1379.3 1662.1 5418.8 6757.7 6940.3 6951.9 6959.0 6736.5 6885.1 6888.3 6895.8 6895.8 2029.3 2061.9 2065.7 2066.7 2073.2 2070.3 2092.6 2099.3 2102.1 2113.2 2003.2 2056.5 2076.1 2076.4 2079.3 2012.5 2041.2 2044.6 2046.7 2047.2 1999.4 2042.1 2054.1 2054.9 2057.9 5490.9 5644.5 6803.4 6881.0 6884.3 3796.3 3899.1 3907.6 3924.6 3939.4 2655.4 2668.5 2707.9 2709.5 2723.3 862.1 868.7 880.2 883.3 888.5 9056.2 9121.2 9132.1 9133.7 9134.0 3849.0 3859.0 3887.5 3905.8 3953.9 7949.0 8040.0 8040.4 8048.0 8070.4 4047.2 4047.3 4059.7 4063.0 4066.1 3701.9 3706.8 3708.2 3710.7 3712.5 3192.3 3193.7 3206.4 3258.4 3258.5 1040.8 1044.6 1045.6 1049.6 1049.9 918.3 930.8 934.3 952.2 954.3 6269.3 6336.2 6344.9 6346.2 6351.8 441.2 450.4 452.8 454.4 457.9 4158.3 5032.8 5060.7 5076.2 5078.6 6865.9 8218.0 8274.5 8353.4 8414.5 8077.4 8176.7 8180.3 8210.2 8229.1 5934.6 6010.6 6038.0 6039.3 6045.2 6323.5 6330.9 6341.0 6348.8 6352.8 7101.9 7350.7 7414.3 7421.1 7486.8 7561.5 7592.8 7600.2 7701.8 7725.9 5641.9 5711.5 5726.1 5747.2 5747.7 6203.0 6279.9 6287.0 6290.2 6290.8 6076.2 6158.9 6210.1 6243.4 6285.0 5961.8 6029.2 6045.2 6081.5 6104.8 5950.5 5998.6 6126.5 6146.5 6150.9 5714.0 5741.8 5759.0 5761.6 5761.9 5552.2 5816.9 5838.4 5844.8 5846.4 05:40:16 INFO - 2015-11-26 05:40:16,288 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-11-26 05:40:16,288 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4665.17 Median:5350.45 stddev:1389.16 (26.0%) stddev-sans-first:1353.83 05:40:16 INFO - 2015-11-26 05:40:16,288 DEBUG : BROWSER_OUTPUT: Values: 298.2 301.9 305.2 305.3 309.5 5317.0 5359.1 5389.2 5395.4 5414.2 5048.9 5169.5 5177.5 5338.1 5341.8 4140.8 4156.4 4165.6 4169.6 4178.0 3899.0 4163.8 4164.1 4170.9 4176.4 3934.5 3982.2 4079.9 4124.8 4161.9 4153.0 4154.8 4157.8 4160.1 4160.9 3645.9 3652.2 3656.6 3657.5 3660.9 5164.9 5186.2 5190.6 5198.0 5198.7 4550.0 4698.3 4720.5 4727.5 4787.1 5582.0 5642.7 5643.0 5645.6 5651.1 3876.2 3877.0 3877.6 3879.7 3880.9 5886.6 5891.6 5928.6 5929.6 5939.4 3824.5 3941.4 3947.8 3951.9 3958.8 3999.6 4001.2 4001.7 4005.9 4013.5 4626.4 4636.3 4640.6 4668.2 4673.3 5654.3 5656.6 5659.7 5661.2 5665.2 1322.6 1322.8 1329.6 1405.7 1410.7 958.7 964.9 968.9 977.8 981.4 4866.4 4868.1 4868.5 4879.4 4879.9 5721.3 5758.4 5806.6 5813.4 5816.9 4905.4 4930.3 4934.2 4938.3 4943.1 3077.1 3108.2 3147.2 3150.5 3151.5 5497.6 5499.1 5514.5 5516.1 5526.9 5967.9 5969.6 5973.6 5976.3 5978.0 5514.2 5517.9 5519.3 5522.3 5525.9 5775.6 5829.9 5964.2 5968.7 5970.5 5797.7 5797.8 5804.1 5812.8 5813.4 5625.2 5634.8 5639.8 5640.1 5641.2 3916.4 4010.2 4070.6 4072.7 4075.1 5612.4 5884.7 5908.3 5910.1 5911.1 5503.4 5533.1 5691.5 5694.2 5696.8 5644.3 5680.6 5683.4 5686.6 5687.2 5537.9 5555.6 5559.2 5559.4 5566.2 5538.2 5644.6 5702.7 5710.4 5712.4 5553.0 5554.2 5559.1 5591.4 5630.9 05:40:16 INFO - 2015-11-26 05:40:16,289 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-11-26 05:40:16,289 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12239.83 Median:22782.17 stddev:14292.74 (62.7%) stddev-sans-first:14306.65 05:40:16 INFO - 2015-11-26 05:40:16,290 DEBUG : BROWSER_OUTPUT: Values: 718.8 720.8 754.4 767.5 771.9 11091.0 11466.2 11481.9 11538.7 11552.1 8899.3 11505.4 11602.4 11608.9 11609.7 764.5 772.7 777.1 777.2 778.0 768.1 774.9 775.3 776.4 779.4 795.6 812.1 814.7 814.8 815.4 804.0 805.5 807.3 808.2 809.3 591.9 596.5 596.7 597.0 597.2 10345.1 10500.6 10545.4 10546.1 10552.9 10741.6 10919.9 10971.5 11014.0 11197.6 8841.2 8849.0 8858.0 8919.9 8980.5 3166.5 3203.1 3237.3 3239.4 3246.3 38253.2 38693.8 38741.8 38780.2 41123.6 8340.7 8347.0 8425.9 8494.7 8724.4 15610.4 15660.1 15697.6 15711.3 15768.1 6094.1 6157.9 6200.3 6255.1 6389.9 3551.0 3644.2 3708.4 3747.5 3750.8 2671.9 2715.7 2716.7 2716.8 2717.5 450.8 451.0 456.2 457.2 458.1 501.0 582.7 588.9 596.4 608.2 7387.4 8604.5 8706.4 8797.7 8817.6 469.9 506.8 561.9 573.6 590.3 3494.7 3536.9 3950.4 3977.3 4015.0 55132.0 55525.0 56080.2 56953.0 57175.4 41403.6 43829.8 44697.3 45108.1 48146.5 40759.8 42717.8 42818.0 42991.4 42992.1 7242.3 7559.7 7681.5 8260.6 8375.6 29825.3 30035.2 30062.8 30645.8 31597.5 36292.0 37092.8 39137.6 39487.2 39815.0 10185.4 10429.7 10455.9 10522.0 10749.1 11104.5 11338.7 11350.5 11434.6 11502.5 10256.2 10365.6 10396.2 10524.9 10578.7 9990.5 10289.2 10576.2 10803.5 11115.2 9778.4 9935.9 9981.6 10159.9 10256.7 8805.9 8817.2 9052.1 9107.6 9287.6 8206.4 8652.7 8781.9 8794.2 8815.5 05:40:16 INFO - 2015-11-26 05:40:16,290 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:40:16 INFO - 2015-11-26 05:40:16,290 DEBUG : BROWSER_OUTPUT: 05:40:17 INFO - 2015-11-26 05:40:17,021 INFO : Browser exited with error code: 0 05:40:17 INFO - 2015-11-26 05:40:17,042 INFO : Completed test dromaeo_css (00:18:39) 05:40:17 INFO - 2015-11-26 05:40:17,042 INFO : Starting test kraken 05:40:17 INFO - 2015-11-26 05:40:17,042 DEBUG : operating with platform_type : linux_ 05:40:17 INFO - 2015-11-26 05:40:17,042 INFO : Initialising browser for kraken test... 05:40:17 INFO - 2015-11-26 05:40:17,048 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTwa9G2/profile http://localhost:42235/getInfo.html 05:40:21 INFO - 2015-11-26 05:40:21,058 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:40:21 INFO - 2015-11-26 05:40:21,059 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:40:21 INFO - 2015-11-26 05:40:21,059 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:40:21 INFO - 2015-11-26 05:40:21,059 DEBUG : BROWSER_OUTPUT: __metrics 05:40:21 INFO - 2015-11-26 05:40:21,147 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] 05:40:22 INFO - 2015-11-26 05:40:22,518 INFO : Browser initialized. 05:40:22 INFO - 2015-11-26 05:40:22,518 INFO : Running cycle 1/1 for kraken test... 05:40:22 INFO - 2015-11-26 05:40:22,519 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTwa9G2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:40:34 INFO - 2015-11-26 05:40:34,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 139530240 05:40:34 INFO - 2015-11-26 05:40:34,431 DEBUG : BROWSER_OUTPUT: 05:40:37 INFO - 2015-11-26 05:40:37,046 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42235/tests/kraken/driver.html?testName=audio-beat-detection) 05:40:37 INFO - 2015-11-26 05:40:37,632 DEBUG : BROWSER_OUTPUT: RSS: Main: 176037888 05:40:37 INFO - 2015-11-26 05:40:37,632 DEBUG : BROWSER_OUTPUT: 05:40:40 INFO - 2015-11-26 05:40:40,362 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42235/tests/kraken/driver.html?testName=audio-dft) 05:40:40 INFO - 2015-11-26 05:40:40,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 167358464 05:40:40 INFO - 2015-11-26 05:40:40,944 DEBUG : BROWSER_OUTPUT: 05:40:43 INFO - 2015-11-26 05:40:43,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42235/tests/kraken/driver.html?testName=audio-fft) 05:40:44 INFO - 2015-11-26 05:40:44,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 151941120 05:40:44 INFO - 2015-11-26 05:40:44,551 DEBUG : BROWSER_OUTPUT: 05:40:46 INFO - 2015-11-26 05:40:46,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42235/tests/kraken/driver.html?testName=audio-oscillator) 05:40:47 INFO - 2015-11-26 05:40:47,156 DEBUG : BROWSER_OUTPUT: RSS: Main: 153407488 05:40:47 INFO - 2015-11-26 05:40:47,156 DEBUG : BROWSER_OUTPUT: 05:40:49 INFO - 2015-11-26 05:40:49,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:40:49 INFO - 2015-11-26 05:40:49,998 DEBUG : BROWSER_OUTPUT: RSS: Main: 154128384 05:40:49 INFO - 2015-11-26 05:40:49,998 DEBUG : BROWSER_OUTPUT: 05:40:52 INFO - 2015-11-26 05:40:52,941 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42235/tests/kraken/driver.html?testName=imaging-darkroom) 05:40:53 INFO - 2015-11-26 05:40:53,515 DEBUG : BROWSER_OUTPUT: RSS: Main: 155054080 05:40:53 INFO - 2015-11-26 05:40:53,515 DEBUG : BROWSER_OUTPUT: 05:40:56 INFO - 2015-11-26 05:40:56,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42235/tests/kraken/driver.html?testName=imaging-desaturate) 05:40:57 INFO - 2015-11-26 05:40:57,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 156700672 05:40:57 INFO - 2015-11-26 05:40:57,484 DEBUG : BROWSER_OUTPUT: 05:41:00 INFO - 2015-11-26 05:41:00,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42235/tests/kraken/driver.html?testName=json-parse-financial) 05:41:00 INFO - 2015-11-26 05:41:00,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 156352512 05:41:00 INFO - 2015-11-26 05:41:00,909 DEBUG : BROWSER_OUTPUT: 05:41:02 INFO - 2015-11-26 05:41:02,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:41:03 INFO - 2015-11-26 05:41:03,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 165515264 05:41:03 INFO - 2015-11-26 05:41:03,236 DEBUG : BROWSER_OUTPUT: 05:41:05 INFO - 2015-11-26 05:41:05,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42235/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:41:05 INFO - 2015-11-26 05:41:05,720 DEBUG : BROWSER_OUTPUT: RSS: Main: 165642240 05:41:05 INFO - 2015-11-26 05:41:05,720 DEBUG : BROWSER_OUTPUT: 05:41:08 INFO - 2015-11-26 05:41:08,377 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:41:08 INFO - 2015-11-26 05:41:08,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 175255552 05:41:08 INFO - 2015-11-26 05:41:08,959 DEBUG : BROWSER_OUTPUT: 05:41:11 INFO - 2015-11-26 05:41:11,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:41:12 INFO - 2015-11-26 05:41:12,087 DEBUG : BROWSER_OUTPUT: RSS: Main: 181202944 05:41:12 INFO - 2015-11-26 05:41:12,087 DEBUG : BROWSER_OUTPUT: 05:41:14 INFO - 2015-11-26 05:41:14,707 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:41:15 INFO - 2015-11-26 05:41:15,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 178626560 05:41:15 INFO - 2015-11-26 05:41:15,280 DEBUG : BROWSER_OUTPUT: 05:41:17 INFO - 2015-11-26 05:41:17,021 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42235/tests/kraken/driver.html?testName=ai-astar) 05:41:17 INFO - 2015-11-26 05:41:17,272 DEBUG : BROWSER_OUTPUT: RSS: Main: 238309376 05:41:17 INFO - 2015-11-26 05:41:17,272 DEBUG : BROWSER_OUTPUT: 05:41:17 INFO - 2015-11-26 05:41:17,273 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:41:17 INFO - 2015-11-26 05:41:17,275 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:41:17 INFO - 2015-11-26 05:41:17,275 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:41:17 INFO - 2015-11-26 05:41:17,275 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:41:17 INFO - 2015-11-26 05:41:17,276 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;113;108;113;112;113;101;112;113;102 05:41:17 INFO - 2015-11-26 05:41:17,276 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;139;153;167;131;151;166;134;174;134 05:41:17 INFO - 2015-11-26 05:41:17,276 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;163;162;162;160;161;164;164;163;163 05:41:17 INFO - 2015-11-26 05:41:17,276 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;77;76;96;72;72;73;84;93;74 05:41:17 INFO - 2015-11-26 05:41:17,276 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;100;136;93;95;94;137;94;93;130 05:41:17 INFO - 2015-11-26 05:41:17,277 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;110;111;110;110;110;109 05:41:17 INFO - 2015-11-26 05:41:17,277 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;148;148;148;147;147;147;147;147 05:41:17 INFO - 2015-11-26 05:41:17,277 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;95;95;96;95;95;95 05:41:17 INFO - 2015-11-26 05:41:17,277 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;70;70;70;71;70;70;70;72;69 05:41:17 INFO - 2015-11-26 05:41:17,277 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;70;69;69;68;69;68;69;69 05:41:17 INFO - 2015-11-26 05:41:17,277 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;84;85;85;88;83;83;87;86;84 05:41:17 INFO - 2015-11-26 05:41:17,277 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;127;128;120;120;121;126;128;121;131 05:41:17 INFO - 2015-11-26 05:41:17,277 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;148;149;146;146;147;148;149;146;135 05:41:17 INFO - 2015-11-26 05:41:17,277 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;68;71;69;68;70;69;69;67;69 05:41:17 INFO - 2015-11-26 05:41:17,278 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:41:17 INFO - 2015-11-26 05:41:17,278 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:41:17 INFO - 2015-11-26 05:41:17,278 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1012 05:41:17 INFO - 2015-11-26 05:41:17,278 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:41:17 INFO - 2015-11-26 05:41:17,278 DEBUG : BROWSER_OUTPUT: __startTimestamp1448545277273__endTimestamp 05:41:17 INFO - 2015-11-26 05:41:17,278 DEBUG : BROWSER_OUTPUT: 05:41:17 INFO - 2015-11-26 05:41:17,281 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:41:17 INFO - 2015-11-26 05:41:17,282 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:41:17 INFO - 2015-11-26 05:41:17,282 DEBUG : BROWSER_OUTPUT: 05:41:17 INFO - 2015-11-26 05:41:17,282 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.90 Median:112.50 stddev:4.68 (4.2%) stddev-sans-first:4.90 05:41:17 INFO - 2015-11-26 05:41:17,282 DEBUG : BROWSER_OUTPUT: Values: 112.0 113.0 108.0 113.0 112.0 113.0 101.0 112.0 113.0 102.0 05:41:17 INFO - 2015-11-26 05:41:17,282 DEBUG : BROWSER_OUTPUT: 05:41:17 INFO - 2015-11-26 05:41:17,282 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.50 Median:154.50 stddev:15.49 (10.0%) stddev-sans-first:16.30 05:41:17 INFO - 2015-11-26 05:41:17,282 DEBUG : BROWSER_OUTPUT: Values: 156.0 139.0 153.0 167.0 131.0 151.0 166.0 134.0 174.0 134.0 05:41:17 INFO - 2015-11-26 05:41:17,282 DEBUG : BROWSER_OUTPUT: 05:41:17 INFO - 2015-11-26 05:41:17,282 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.27 (0.8%) stddev-sans-first:1.33 05:41:17 INFO - 2015-11-26 05:41:17,283 DEBUG : BROWSER_OUTPUT: Values: 163.0 163.0 162.0 162.0 160.0 161.0 164.0 164.0 163.0 163.0 05:41:17 INFO - 2015-11-26 05:41:17,283 DEBUG : BROWSER_OUTPUT: 05:41:17 INFO - 2015-11-26 05:41:17,283 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.90 Median:76.50 stddev:9.01 (11.8%) stddev-sans-first:9.21 05:41:17 INFO - 2015-11-26 05:41:17,283 DEBUG : BROWSER_OUTPUT: Values: 72.0 77.0 76.0 96.0 72.0 72.0 73.0 84.0 93.0 74.0 05:41:17 INFO - 2015-11-26 05:41:17,283 DEBUG : BROWSER_OUTPUT: 05:41:17 INFO - 2015-11-26 05:41:17,283 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.60 Median:93.50 stddev:19.32 (20.7%) stddev-sans-first:19.95 05:41:17 INFO - 2015-11-26 05:41:17,283 DEBUG : BROWSER_OUTPUT: Values: 94.0 100.0 136.0 93.0 95.0 94.0 137.0 94.0 93.0 130.0 05:41:17 INFO - 2015-11-26 05:41:17,283 DEBUG : BROWSER_OUTPUT: 05:41:17 INFO - 2015-11-26 05:41:17,283 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:41:17 INFO - 2015-11-26 05:41:17,284 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 110.0 111.0 110.0 110.0 110.0 109.0 05:41:17 INFO - 2015-11-26 05:41:17,284 DEBUG : BROWSER_OUTPUT: 05:41:17 INFO - 2015-11-26 05:41:17,284 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 05:41:17 INFO - 2015-11-26 05:41:17,284 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 148.0 148.0 148.0 147.0 147.0 147.0 147.0 147.0 05:41:17 INFO - 2015-11-26 05:41:17,284 DEBUG : BROWSER_OUTPUT: 05:41:17 INFO - 2015-11-26 05:41:17,284 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:41:17 INFO - 2015-11-26 05:41:17,285 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 05:41:17 INFO - 2015-11-26 05:41:17,285 DEBUG : BROWSER_OUTPUT: 05:41:17 INFO - 2015-11-26 05:41:17,285 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.10 Median:70.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 05:41:17 INFO - 2015-11-26 05:41:17,285 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 70.0 70.0 71.0 70.0 70.0 70.0 72.0 69.0 05:41:17 INFO - 2015-11-26 05:41:17,285 DEBUG : BROWSER_OUTPUT: 05:41:17 INFO - 2015-11-26 05:41:17,285 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 05:41:17 INFO - 2015-11-26 05:41:17,285 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 70.0 69.0 69.0 68.0 69.0 68.0 69.0 69.0 05:41:17 INFO - 2015-11-26 05:41:17,285 DEBUG : BROWSER_OUTPUT: 05:41:17 INFO - 2015-11-26 05:41:17,285 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.00 stddev:2.07 (2.4%) stddev-sans-first:1.73 05:41:17 INFO - 2015-11-26 05:41:17,285 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 85.0 85.0 88.0 83.0 83.0 87.0 86.0 84.0 05:41:17 INFO - 2015-11-26 05:41:17,285 DEBUG : BROWSER_OUTPUT: 05:41:17 INFO - 2015-11-26 05:41:17,285 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:127.50 stddev:4.08 (3.2%) stddev-sans-first:4.18 05:41:17 INFO - 2015-11-26 05:41:17,285 DEBUG : BROWSER_OUTPUT: Values: 128.0 127.0 128.0 120.0 120.0 121.0 126.0 128.0 121.0 131.0 05:41:17 INFO - 2015-11-26 05:41:17,285 DEBUG : BROWSER_OUTPUT: 05:41:17 INFO - 2015-11-26 05:41:17,285 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.10 Median:147.50 stddev:4.07 (2.8%) stddev-sans-first:4.30 05:41:17 INFO - 2015-11-26 05:41:17,285 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 149.0 146.0 146.0 147.0 148.0 149.0 146.0 135.0 05:41:17 INFO - 2015-11-26 05:41:17,286 DEBUG : BROWSER_OUTPUT: 05:41:17 INFO - 2015-11-26 05:41:17,286 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 05:41:17 INFO - 2015-11-26 05:41:17,286 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 71.0 69.0 68.0 70.0 69.0 69.0 67.0 69.0 05:41:17 INFO - 2015-11-26 05:41:17,286 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:41:17 INFO - 2015-11-26 05:41:17,286 DEBUG : BROWSER_OUTPUT: 05:41:18 INFO - 2015-11-26 05:41:18,149 INFO : Browser exited with error code: 0 05:41:18 INFO - 2015-11-26 05:41:18,199 INFO : Completed test kraken (00:01:01) 05:41:18 INFO - 2015-11-26 05:41:18,199 INFO : Starting test v8_7 05:41:18 INFO - 2015-11-26 05:41:18,199 DEBUG : operating with platform_type : linux_ 05:41:18 INFO - 2015-11-26 05:41:18,199 INFO : Initialising browser for v8_7 test... 05:41:18 INFO - 2015-11-26 05:41:18,205 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmYVM8n/profile http://localhost:42235/getInfo.html 05:41:22 INFO - 2015-11-26 05:41:22,303 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:41:22 INFO - 2015-11-26 05:41:22,303 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:41:22 INFO - 2015-11-26 05:41:22,303 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:41:22 INFO - 2015-11-26 05:41:22,303 DEBUG : BROWSER_OUTPUT: __metrics 05:41:22 INFO - 2015-11-26 05:41:22,399 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] 05:41:23 INFO - 2015-11-26 05:41:23,875 INFO : Browser initialized. 05:41:23 INFO - 2015-11-26 05:41:23,876 INFO : Running cycle 1/1 for v8_7 test... 05:41:23 INFO - 2015-11-26 05:41:23,876 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmYVM8n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:41:35 INFO - 2015-11-26 05:41:35,806 DEBUG : BROWSER_OUTPUT: RSS: Main: 139685888 05:41:35 INFO - 2015-11-26 05:41:35,806 DEBUG : BROWSER_OUTPUT: 05:41:57 INFO - 2015-11-26 05:41:57,204 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42235/tests/v8_7/run.html (next: http://localhost:42235/tests/v8_7/run.html) 05:41:57 INFO - 2015-11-26 05:41:57,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 438460416 05:41:57 INFO - 2015-11-26 05:41:57,454 DEBUG : BROWSER_OUTPUT: 05:41:57 INFO - 2015-11-26 05:41:57,455 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:41:57 INFO - 2015-11-26 05:41:57,455 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:41:57 INFO - 2015-11-26 05:41:57,455 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:41:57 INFO - 2015-11-26 05:41:57,456 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:41:57 INFO - 2015-11-26 05:41:57,456 DEBUG : BROWSER_OUTPUT: |0;Richards;165.371258475277 05:41:57 INFO - 2015-11-26 05:41:57,456 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.41870309794112 05:41:57 INFO - 2015-11-26 05:41:57,457 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.78449958182324 05:41:57 INFO - 2015-11-26 05:41:57,457 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 05:41:57 INFO - 2015-11-26 05:41:57,457 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2020.20202020202 05:41:57 INFO - 2015-11-26 05:41:57,458 DEBUG : BROWSER_OUTPUT: |5;Earley;799.3605115907275 05:41:57 INFO - 2015-11-26 05:41:57,458 DEBUG : BROWSER_OUTPUT: |6;Boyer;12382.716049382716 05:41:57 INFO - 2015-11-26 05:41:57,458 DEBUG : BROWSER_OUTPUT: |7;RegExp;26205.128205128207 05:41:57 INFO - 2015-11-26 05:41:57,459 DEBUG : BROWSER_OUTPUT: |8;Splay;622.5124378109452 05:41:57 INFO - 2015-11-26 05:41:57,459 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 05:41:57 INFO - 2015-11-26 05:41:57,459 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:41:57 INFO - 2015-11-26 05:41:57,459 DEBUG : BROWSER_OUTPUT: __startTimestamp1448545317451__endTimestamp 05:41:57 INFO - 2015-11-26 05:41:57,460 DEBUG : BROWSER_OUTPUT: 05:41:57 INFO - 2015-11-26 05:41:57,460 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:41:57 INFO - 2015-11-26 05:41:57,460 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:41:57 INFO - 2015-11-26 05:41:57,461 DEBUG : BROWSER_OUTPUT: 05:41:57 INFO - 2015-11-26 05:41:57,461 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.37 Median:165.37 stddev:0.00 (0.0%) 05:41:57 INFO - 2015-11-26 05:41:57,461 DEBUG : BROWSER_OUTPUT: Values: 165.4 05:41:57 INFO - 2015-11-26 05:41:57,462 DEBUG : BROWSER_OUTPUT: 05:41:57 INFO - 2015-11-26 05:41:57,462 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.42 Median:192.42 stddev:0.00 (0.0%) 05:41:57 INFO - 2015-11-26 05:41:57,462 DEBUG : BROWSER_OUTPUT: Values: 192.4 05:41:57 INFO - 2015-11-26 05:41:57,462 DEBUG : BROWSER_OUTPUT: 05:41:57 INFO - 2015-11-26 05:41:57,462 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.78 Median:278.78 stddev:0.00 (0.0%) 05:41:57 INFO - 2015-11-26 05:41:57,463 DEBUG : BROWSER_OUTPUT: Values: 278.8 05:41:57 INFO - 2015-11-26 05:41:57,463 DEBUG : BROWSER_OUTPUT: 05:41:57 INFO - 2015-11-26 05:41:57,463 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 05:41:57 INFO - 2015-11-26 05:41:57,463 DEBUG : BROWSER_OUTPUT: Values: 5181.3 05:41:57 INFO - 2015-11-26 05:41:57,464 DEBUG : BROWSER_OUTPUT: 05:41:57 INFO - 2015-11-26 05:41:57,464 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2020.20 Median:2020.20 stddev:0.00 (0.0%) 05:41:57 INFO - 2015-11-26 05:41:57,464 DEBUG : BROWSER_OUTPUT: Values: 2020.2 05:41:57 INFO - 2015-11-26 05:41:57,464 DEBUG : BROWSER_OUTPUT: 05:41:57 INFO - 2015-11-26 05:41:57,465 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:799.36 Median:799.36 stddev:0.00 (0.0%) 05:41:57 INFO - 2015-11-26 05:41:57,465 DEBUG : BROWSER_OUTPUT: Values: 799.4 05:41:57 INFO - 2015-11-26 05:41:57,465 DEBUG : BROWSER_OUTPUT: 05:41:57 INFO - 2015-11-26 05:41:57,465 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 05:41:57 INFO - 2015-11-26 05:41:57,465 DEBUG : BROWSER_OUTPUT: Values: 12382.7 05:41:57 INFO - 2015-11-26 05:41:57,465 DEBUG : BROWSER_OUTPUT: 05:41:57 INFO - 2015-11-26 05:41:57,465 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26205.13 Median:26205.13 stddev:0.00 (0.0%) 05:41:57 INFO - 2015-11-26 05:41:57,465 DEBUG : BROWSER_OUTPUT: Values: 26205.1 05:41:57 INFO - 2015-11-26 05:41:57,465 DEBUG : BROWSER_OUTPUT: 05:41:57 INFO - 2015-11-26 05:41:57,465 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:622.51 Median:622.51 stddev:0.00 (0.0%) 05:41:57 INFO - 2015-11-26 05:41:57,466 DEBUG : BROWSER_OUTPUT: Values: 622.5 05:41:57 INFO - 2015-11-26 05:41:57,466 DEBUG : BROWSER_OUTPUT: 05:41:57 INFO - 2015-11-26 05:41:57,466 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 05:41:57 INFO - 2015-11-26 05:41:57,466 DEBUG : BROWSER_OUTPUT: Values: 4830.9 05:41:57 INFO - 2015-11-26 05:41:57,466 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:41:57 INFO - 2015-11-26 05:41:57,466 DEBUG : BROWSER_OUTPUT: 05:41:58 INFO - 2015-11-26 05:41:58,282 INFO : Browser exited with error code: 0 05:41:58 INFO - 2015-11-26 05:41:58,298 INFO : Completed test v8_7 (00:00:40) 05:41:58 INFO - 2015-11-26 05:41:58,515 INFO : Completed test suite (00:20:20) 05:41:58 INFO - 2015-11-26 05:41:58,515 DEBUG : Working with test: dromaeo_css 05:41:58 INFO - 2015-11-26 05:41:58,515 DEBUG : Generating results file: dromaeo_css 05:41:58 INFO - 2015-11-26 05:41:58,517 DEBUG : Working with test: kraken 05:41:58 INFO - 2015-11-26 05:41:58,517 DEBUG : Generating results file: kraken 05:41:58 INFO - 2015-11-26 05:41:58,517 INFO : javascript benchmark 05:41:58 INFO - 2015-11-26 05:41:58,517 DEBUG : Working with test: v8_7 05:41:58 INFO - 2015-11-26 05:41:58,518 DEBUG : Generating results file: v8_7 05:41:58 INFO - 2015-11-26 05:41:58,518 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:41:58 INFO - 2015-11-26 05:41:58,654 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 05:41:58 INFO - 2015-11-26 05:41:58,654 DEBUG : process_Request line: dromaeo_css 6183.12 graph.html#tests=[[72,132,35]] 05:41:58 INFO - 2015-11-26 05:41:58,654 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:41:58 INFO - 2015-11-26 05:41:58,686 DEBUG : process_Request line: kraken 1524.50 graph.html#tests=[[232,132,35]] 05:41:58 INFO - 2015-11-26 05:41:58,686 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:41:58 INFO - 2015-11-26 05:41:58,717 DEBUG : process_Request line: v8_7 19652.50 graph.html#tests=[[230,132,35]] 05:41:58 INFO - 2015-11-26 05:41:58,718 INFO : javascript benchmark 05:41:58 INFO - 2015-11-26 05:41:58,722 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2636.472705458908, 2712.837229766214, 2713.2674177971962, 2732.453509298141, 2745.6705195376553, 4515.706479078865, 4613.792379342929, 4667.556582124701, 4679.532046795319, 4703.223968045273, 4523.253663145585, 4549.135664223803, 4642.489326174118, 4643.0481751240995, 4649.9070018599605, 4276.700630955826, 4291.721038132527, 4297.0, 4317.525072242051, 4331.913361732779, 4080.5715399882884, 4387.385765992748, 4400.405945197405, 4434.268345722952, 4437.511873693891, 4179.185058913528, 4181.811818468176, 4195.056112374722, 4305.461817272841, 4309.5690430956965, 4301.37630043645, 4302.440682711259, 4310.913781724379, 4314.61168494837, 4355.259605867011, 4271.1671224111315, 4273.038566322583, 4278.144371125787, 4309.310510318334, 4325.221460137174, 4341.761203133827, 4452.131834292314, 4467.30756732707, 4468.4414448193975, 4596.241620132674, 4970.13022721026, 5023.171176755831, 5025.648204625678, 5029.19532874742, 5073.061483625541, 5056.646034777567, 5058.367704036996, 5060.165072763027, 5065.290859279704, 5068.087744206042, 4492.505824359318, 4564.360989461478, 4603.539646035403, 4604.355390245369, 4605.585497305258, 5156.355455568054, 5161.509656582619, 5162.6386152968935, 5169.172932330809, 5211.635185536976, 4934.703917764946, 4937.901241975141, 4938.086454005948, 4940.802367905316, 4983.975080124576, 4804.783784729696, 4891.266310053449, 4903.068417000758, 4907.754612269372, 5016.824411145592, 4963.0, 4999.075171093286, 4999.525045120708, 5002.474740152232, 5008.774605142778, 4962.652614317035, 4971.080350135237, 4973.229149481836, 4974.228994505857, 4999.825006124768, 3963.4451176835264, 4009.7393669411977, 4042.130941847458, 4077.510698716114, 4206.726562773471, 3638.6725194732603, 3662.450632405107, 3672.5042119314085, 3674.0, 3694.9815250923575, 4336.371226172188, 4343.3484977253665, 4346.391505189276, 4387.5393083726385, 4389.648828093745, 4798.95201047992, 4909.852704418873, 4931.457539670633, 5062.341895553554, 5063.974680126576, 4219.472565929259, 4233.957660423356, 4264.530901600821, 4311.267084595626, 4335.956640433618, 4432.689711720149, 4455.353973673799, 4469.865904022885, 4475.507694153641, 4512.300593408027, 4527.90944181108, 4636.188666983332, 4639.4896561377545, 4790.976045119683, 4799.856004319876, 4850.957044235506, 4927.827526036572, 4944.554990050912, 4946.480619534897, 4992.900141997067, 4713.528647135259, 4762.380890484214, 4765.380500534909, 4771.7375544344, 4808.0383923216195, 4691.272852707836, 4774.188387974123, 4777.211760059551, 4939.580135688507, 4976.377952755905, 4867.123917694707, 4977.0792403405485, 4993.675411098412, 4997.100521906092, 5009.749512524287, 4843.806247750051, 4855.1260773061185, 4856.8300109495995, 4858.975705121452, 4907.975460122677, 4589.059242855274, 4707.035057813072, 4707.764611769467, 4858.951410485991, 4908.018396320679, 4711.246200607886, 4760.571548560646, 4767.785449654843, 4775.0, 4831.178699621002, 4885.804567817389, 4897.926531101965, 4928.088303663833, 4936.950630493649, 4950.529699678525, 4599.632029437704, 4689.507601701772, 4708.081924024782, 4820.373351464287, 4878.707277563216], "unit": "ms", "name": "dojo.html", "value": 4563.904865248226}, {"lowerIsBetter": false, "replicates": [493.2773486841776, 498.1407072799424, 570.9771609135634, 576.5070864410928, 579.9913001304981, 20410.0, 20516.48708782281, 20705.0, 20741.481462963435, 36541.45187822185, 40407.39388909161, 40873.0, 40941.0, 40968.79515602425, 40987.18025639485, 7949.443538952261, 8108.2297181767635, 8112.634931428071, 8113.43205975582, 8115.675372985073, 6677.565958212725, 6833.6241506717115, 8001.5199088054615, 10310.0, 10575.365478071302, 10257.230707696915, 10362.326448780843, 10362.637307694233, 10365.948170259138, 10374.32566883154, 6729.663516824139, 10273.434961077137, 10402.219833512441, 10402.895971040343, 10406.583736650562, 6659.966700166517, 10352.741181470523, 10599.046085852311, 10615.0, 10627.04356607909, 37006.25987480235, 37642.0, 37658.24683506342, 37681.24637507235, 37695.0, 2757.3658058646624, 2903.4483448144997, 2905.2155917902046, 3091.442723100609, 3278.4754439289836, 27796.861015694994, 28149.437011259866, 28212.294692632644, 28345.0, 28547.143585692254, 3366.5239470277706, 3449.275652113059, 3462.255615042778, 3539.50446937429, 3575.4279315309427, 230054.0, 232032.0, 232252.9999999983, 232946.0, 233414.0, 46054.76972615116, 46291.0, 46302.0, 46302.76848615735, 46354.0, 35325.646743532234, 36172.81913590415, 58717.11924321053, 61090.0, 61263.081053784226, 12473.563425280072, 12571.497140114476, 12633.115681902362, 12666.873331266754, 12692.492300307884, 10223.846642300372, 10299.073083422529, 10316.43259620713, 10327.483625818679, 10340.276180667432, 19359.483267175176, 19581.412557623295, 19652.312169074015, 19666.213351466067, 19670.114844832016, 7478.925210747823, 7619.580923049175, 7683.615819209017, 7706.730264440717, 7717.614119294013, 774.5701135869647, 780.2470615855613, 818.8157664525553, 854.4616891358529, 915.688665853613, 26439.0, 26575.468490630465, 26779.196624101307, 26792.33019174536, 26870.0, 943.9622415103319, 967.3373738988815, 986.6398764450923, 1005.3013155856755, 1010.1161483701761, 13280.136791108547, 13440.193588384729, 14980.475683351031, 16145.354185832435, 16287.674246515004, 345425.0, 346733.0, 347780.0, 349027.0, 349310.0, 47298.76350618225, 48045.0, 48173.0, 48175.27737083947, 48192.0, 1016.5222345497605, 1185.697647099984, 1210.8244304575787, 1211.6183402228446, 1213.7815193265296, 27401.45197096087, 28261.57607635846, 28323.433531328847, 28561.0, 30733.616987236077, 24961.0, 25556.488870222864, 42094.57905420907, 43556.34665479957, 43595.0, 247137.0, 251244.0, 253190.0, 253557.0, 254118.0, 35324.82337588296, 35668.286634267686, 35904.64095359013, 35914.820425897706, 35953.46069809007, 38916.80541597274, 38981.99322517401, 42567.57432425636, 42615.147697045264, 42835.57164428316, 32601.18497037593, 32657.836710816293, 32814.0, 32989.83505082459, 33358.66489345722, 35234.11914702153, 35460.82269588635, 35653.28693426169, 36050.819745901106, 36200.818995904854, 35042.824785876925, 35112.0, 35269.0, 35477.29045419129, 35591.46612800758, 31419.371612568077, 32188.678113219506, 32356.676433235367, 32371.51442728408, 32403.0, 24257.393565160306, 24497.51004979926, 24690.876545617157, 25302.367440813392, 25429.61855572131], "unit": "ms", "name": "ext.html", "value": 17238.29998566275}, {"lowerIsBetter": false, "replicates": [332.21762748726746, 334.56673607678056, 335.6039872949919, 336.02217546938414, 338.71886334342497, 11150.052245559138, 11549.480273387697, 15057.698846023086, 15444.845551544482, 15523.844761552382, 7660.080790305157, 9499.905000949988, 9818.263630227726, 11702.531898724063, 15066.3220155093, 4545.454545454541, 4630.166570017395, 4649.163150632885, 4659.697119687226, 4664.183767840631, 3194.2174167329035, 4337.739735615857, 4524.389207457, 5226.947730522684, 5228.424873263957, 5170.327857378536, 5189.169732842746, 5195.792168313263, 5200.68795872247, 5215.087359712054, 5036.697798132123, 5156.278121063054, 5160.741962901859, 5163.302954101224, 5174.301469301652, 4985.675931064469, 4989.600831933437, 5017.573506251973, 5018.322526458918, 5052.115879721071, 11682.24065435744, 11971.102167337398, 18207.08964551767, 18338.908305458386, 18355.357562485384, 1794.97307540387, 1807.9638407231914, 1812.0215083854703, 1837.5314294854861, 1847.4919397165752, 9027.864582031209, 9084.818303633956, 9283.071692830663, 9351.205147562465, 9366.391184572982, 1646.9176541173013, 1710.2731339180923, 1748.6327871147075, 1770.1060964213118, 1815.473512681321, 54832.0, 55917.161242581395, 56098.0, 56657.43342566563, 56867.431325687045, 9714.75713107178, 9801.31390802637, 9834.459104749307, 9837.409755414556, 9862.457564834003, 12462.750744985231, 12491.562795302121, 12501.749965000648, 12502.687432814071, 12506.124571279923, 6176.81469555914, 6391.392817682313, 6645.435138013323, 6832.59004459734, 6928.861422771516, 6350.809475715643, 6370.904436433365, 6424.26120996082, 6437.420632143129, 6508.056331831858, 4102.138550904284, 4128.277551428488, 4150.377443383456, 4207.579242075829, 4234.640055595247, 1440.5102265229873, 1492.6790739990954, 1494.1174120608111, 1494.6473441535427, 1706.334529533483, 798.5568009754642, 800.5756948817136, 861.8491763941286, 888.995435158267, 919.5402298850574, 14063.2968351582, 14514.274286285643, 14955.401783928739, 15493.612659683598, 15607.063576185465, 618.2673531864755, 791.1297572670017, 801.2988634944423, 808.1231863428246, 830.2361827119065, 7995.520268783892, 8446.155384461505, 8508.191721786421, 8672.349573781992, 8890.688825891062, 483771.0, 487513.0, 492132.0, 509635.0, 511465.0, 74101.0, 74655.0, 75079.0, 75212.0, 75377.6231118841, 1045.153425725165, 1054.99472502637, 1061.543536279392, 1063.1388575254068, 1065.2383545764815, 13402.664933376744, 13679.726405471636, 13931.442742290601, 13990.860091398956, 14272.14367137975, 29261.268468288465, 29492.852535737184, 30362.696373035986, 32310.35379292448, 32904.0, 39333.819985400485, 39971.80014099911, 40540.797296013334, 41530.0, 42951.0, 8564.0, 8911.019787823463, 9055.728328150166, 9109.453432794053, 9122.087791220825, 10608.840867387149, 10729.785404292026, 13196.868031319564, 15364.385424582892, 15794.210289485709, 13375.331233438095, 13521.729565408834, 13522.729545409233, 13542.390592423562, 13555.525556605471, 12931.676708082374, 13469.0, 13476.0, 13613.910887129205, 13950.372233249325, 9365.531723413938, 13684.931575342458, 13880.403753568065, 13901.86098139046, 14001.579952601438, 6992.601479703978, 7181.856362872818, 8387.622556984828, 8526.872096918427, 8527.872081918653, 2349.8120150388268, 9052.864207036768, 11549.48027338755, 13144.333761514525, 13508.121972071784], "unit": "ms", "name": "jquery.html", "value": 7827.063147937235}, {"lowerIsBetter": false, "replicates": [948.6395169835462, 1210.4492455932548, 1261.9432125554351, 1379.3379177994561, 1662.1439958421415, 5418.837434876955, 6757.729690812368, 6940.340667636567, 6951.860962780741, 6958.965205173967, 6736.461083113351, 6885.104936358266, 6888.276730943241, 6895.827604309895, 6895.827604309895, 2029.3100345882397, 2061.907214175358, 2065.7417822772154, 2066.6693329067352, 2073.170731707314, 2070.285751415759, 2092.602405542942, 2099.3492017474555, 2102.1381233694187, 2113.2286715348864, 2003.1586733571862, 2056.4858785303672, 2076.117649998752, 2076.397844625057, 2079.2722547108465, 2012.4868158619531, 2041.2447394464143, 2044.5604195097976, 2046.6827641715558, 2047.170895787201, 1999.3701983875033, 2042.1320938601036, 2054.1064636882857, 2054.9486262843398, 2057.8765274083453, 5490.917636235459, 5644.548436125141, 6803.421709154678, 6881.036654868322, 6884.311568843075, 3796.335641262768, 3899.122697393064, 3907.648311651965, 3924.5879182685976, 3939.3893946438347, 2655.4290827472187, 2668.5330067238156, 2707.905223317194, 2709.525832979221, 2723.3463968647384, 862.1163307609751, 868.7089824908663, 880.190224993008, 883.3463237204487, 888.506878682331, 9056.184943355063, 9121.224695900857, 9132.08679132088, 9133.680321188727, 9133.954330228373, 3849.0377405648587, 3859.0, 3887.475190849256, 3905.7851818150275, 3953.8616148435244, 7949.0, 8040.0, 8040.39697022714, 8047.994000749906, 8070.394720395994, 4047.1500984793524, 4047.291723948297, 4059.715819892638, 4063.0248740302113, 4066.1257829566784, 3701.925961480755, 3706.777593344408, 3708.2398108387715, 3710.7216958728204, 3712.5173727415263, 3192.265778870826, 3193.664665210166, 3206.3907857506997, 3258.3809076275434, 3258.462353711611, 1040.843873418978, 1044.566504900473, 1045.5556388534842, 1049.632628579991, 1049.9370037797758, 918.2791508665665, 930.7580029192324, 934.3366209990983, 952.1668540027476, 954.3176628710505, 6269.310375858652, 6336.1762970814425, 6344.904826427607, 6346.2067241594805, 6351.777687780906, 441.23225587478197, 450.4234579737941, 452.8482958208971, 454.38884700079, 457.90384019355645, 4158.334666453353, 5032.823851165192, 5060.671056381323, 5076.162433198481, 5078.568321692697, 6865.862682746317, 8218.0, 8274.544900030436, 8353.37349698775, 8414.537200454033, 8077.434579579491, 8176.67293308261, 8180.345572354197, 8210.220029097227, 8229.094799572042, 5934.554908381889, 6010.639361638316, 6037.969810151009, 6039.305479869871, 6045.21412216409, 6323.494120470444, 6330.873382532415, 6340.968295158679, 6348.809535713936, 6352.809415717536, 7101.8579628406105, 7350.669219885011, 7414.295641914009, 7421.109466864011, 7486.812829679302, 7561.470697051153, 7592.8481430369975, 7600.1639819618695, 7701.80745481345, 7725.922740772745, 5641.887162256814, 5711.543076553949, 5726.112452569859, 5747.224124743107, 5747.683877386784, 6203.0, 6279.937200628118, 6287.0, 6290.150829637941, 6290.842728931813, 6076.210092688099, 6158.938410615837, 6210.130581718653, 6243.43809057187, 6284.968575157095, 5961.791337303347, 6029.246344206974, 6045.214122164267, 6081.543884208613, 6104.816855494342, 5950.523958083257, 5998.610090344114, 6126.540509461719, 6146.5390095742105, 6150.938490615036, 5714.0, 5741.827745167651, 5759.0209664356325, 5761.567882408753, 5761.942380576141, 5552.194931734795, 5816.883662326814, 5838.357780644211, 5844.824655260349, 5846.386129456516], "unit": "ms", "name": "mootools.html", "value": 3821.1604334665317}, {"lowerIsBetter": false, "replicates": [298.17703139335435, 301.89282804604363, 305.1577645697874, 305.25213227592377, 309.4908874900788, 5317.0, 5359.1425371940495, 5389.191621256813, 5395.37953135389, 5414.187871819229, 5048.949510504894, 5169.457206993258, 5177.456367081459, 5338.1192103303, 5341.759620817063, 4140.7515549067, 4156.376543518474, 4165.604267594574, 4169.603887630686, 4178.039051018252, 3898.9805050974705, 4163.812628431712, 4164.146349998243, 4170.916581668364, 4176.394422808691, 3934.5081864766903, 3982.1637456134245, 4079.938800917989, 4124.752514849119, 4161.895952601179, 4153.044799696087, 4154.833806647731, 4157.812898419578, 4160.084781348099, 4160.8959776005695, 3645.908852278688, 3652.2330310634798, 3656.597774244831, 3657.5062366580437, 3660.871869484582, 5164.948350516484, 5186.222066689989, 5190.558802501791, 5197.974010129963, 5198.740062996872, 4549.954500454986, 4698.295255711637, 4720.457147428056, 4727.45634252062, 4787.066522028206, 5582.0, 5642.746076426571, 5642.971785141089, 5645.576581756343, 5651.124075768222, 3876.186000939806, 3877.0, 3877.5540812806607, 3879.650831425157, 3880.8835734927998, 5886.587938844283, 5891.587588868781, 5928.555358348141, 5929.64422134669, 5939.4357536034, 3824.541055073353, 3941.3890846918775, 3947.8026098695523, 3951.940720889189, 3958.782266975344, 3999.560048394674, 4001.1797581495725, 4001.7398869073418, 4005.939910901339, 4013.4581831452965, 4626.352310676508, 4636.258198688193, 4640.559146881041, 4668.183067963161, 4673.275642275453, 5654.321481422256, 5656.632318899258, 5659.717014149276, 5661.207430959669, 5665.235193248941, 1322.6494978830617, 1322.8305578850693, 1329.5745361484426, 1405.7188562287583, 1410.7037522120265, 958.6740508227236, 964.8697425847561, 968.8692026576463, 977.8435450327913, 981.3670182732097, 4866.416030076413, 4868.050730107595, 4868.464468908417, 4879.39007624047, 4879.902401951941, 5721.313442386941, 5758.366579676316, 5806.590265040046, 5813.360530341659, 5816.94183058164, 4905.362302900671, 4930.33440485537, 4934.210526315772, 4938.308636790852, 4943.085529177114, 3077.1384012476096, 3108.2384815720293, 3147.244661281322, 3150.480170771797, 3151.5430262611794, 5497.642653227527, 5499.092649712753, 5514.476124768141, 5516.089845175501, 5526.889462210734, 5967.850803729942, 5969.552283578749, 5973.611715238496, 5976.252968378953, 5978.043513037893, 5514.228008078872, 5517.944820551743, 5519.31008623922, 5522.282103326542, 5525.861853453695, 5775.566832487496, 5829.883402332014, 5964.165016897551, 5968.70156492165, 5970.522358211246, 5797.739101740516, 5797.797077102281, 5804.100364443518, 5812.796552120655, 5813.447722466359, 5625.156226566048, 5634.830955071355, 5639.774409023593, 5640.097584386478, 5641.153826925994, 3916.373380259145, 4010.1779135276615, 4070.5522392536204, 4072.6538244249573, 4075.0831063010587, 5612.382637909908, 5884.705764711833, 5908.261467316585, 5910.083936989773, 5911.054231322968, 5503.394626591152, 5533.14236293359, 5691.4877661010705, 5694.231278777312, 5696.772129114955, 5644.322681278109, 5680.602357834912, 5683.3748287687495, 5686.630369026, 5687.175359572756, 5537.9169312459535, 5555.555555555627, 5559.221708960829, 5559.360673522597, 5566.165075238747, 5538.169274608841, 5644.6330988485615, 5702.743376547983, 5710.428957104256, 5712.428757124254, 5552.972235138798, 5554.222408862844, 5559.138333558305, 5591.412901645269, 5630.943690563042], "unit": "ms", "name": "prototype.html", "value": 4215.134246990082}, {"lowerIsBetter": false, "replicates": [718.8346680263543, 720.7729565186966, 754.4077898849403, 767.5433117295207, 771.8610650082985, 11091.0, 11466.19736618436, 11481.885181148185, 11538.711532211679, 11552.075833933275, 8899.33255005874, 11505.367204803733, 11602.361870097142, 11608.94195529021, 11609.709757256072, 764.5374548398222, 772.6947855597036, 777.1063277231173, 777.2188950105136, 778.0119248554332, 768.06679883941, 774.9263819937097, 775.3370867907942, 776.3827756933223, 779.4349096904728, 795.5823192823756, 812.0985705866483, 814.6822739131743, 814.7515007922581, 815.351795322717, 804.0110663883397, 805.4885147931047, 807.3339494916688, 808.2442915873677, 809.3161278719502, 591.857954091015, 596.5436441122545, 596.7076132694991, 596.964182149068, 597.2444857255575, 10345.120664743506, 10500.632477863315, 10545.36727796327, 10546.103581195608, 10552.947235263775, 10741.62404315853, 10919.945400272947, 10971.451427428598, 11014.0, 11197.552097916156, 8841.204291613785, 8848.955755221246, 8858.0, 8919.910800892038, 8980.46117232968, 3166.493361062242, 3203.0711093782775, 3237.3363460490777, 3239.4492936200904, 3246.253361726816, 38253.23493530114, 38693.80653096745, 38741.80629096865, 38780.22439551221, 41123.588764112275, 8340.708075217459, 8347.0, 8425.915740842636, 8494.74515764528, 8724.389292749447, 15610.3755849767, 15660.060396376253, 15697.607559810867, 15711.292991815395, 15768.132752698482, 6094.146819445281, 6157.907631385533, 6200.255969283625, 6255.093011513396, 6389.8722025560155, 3551.0057183988524, 3644.21649345392, 3708.4066549352515, 3747.45661879026, 3750.7937063461227, 2671.866406679658, 2715.714849940767, 2716.660417447819, 2716.8369897806197, 2717.4972630063503, 450.79263538772534, 450.9932351014737, 456.24946962247583, 457.2455448509985, 458.08611819419804, 501.0280056690082, 582.6999095465839, 588.8910551547978, 596.4035964035965, 608.2062907905226, 7387.372073373716, 8604.526751028754, 8706.434081784664, 8797.736067917973, 8817.559122043873, 469.91071696377577, 506.8479456163136, 561.8763871948165, 573.6443405088871, 590.2739630254811, 3494.7029502492064, 3536.91157721059, 3950.4469374287623, 3977.2840888639744, 4014.979925100414, 55132.0, 55525.0, 56080.15879761807, 56953.0, 57175.42824571784, 41403.58596414058, 43829.780851095544, 44697.329540056926, 45108.09783804305, 48146.5185348149, 40759.796201018806, 42717.786411068366, 42818.0, 42991.35512967308, 42992.06535705901, 7242.275772422716, 7559.659815308214, 7681.462297639112, 8260.628271727666, 8375.581220938806, 29825.25436864096, 30035.249118772204, 30062.849685752306, 30645.846770766002, 31597.526037109, 36292.0, 37092.81453592823, 39137.608623913395, 39487.21025579415, 39815.0, 10185.439800811026, 10429.68710938673, 10455.947720261654, 10522.0, 10749.14006879432, 11104.500297486471, 11338.659840204808, 11350.54597816078, 11434.599789007345, 11502.48238829238, 10256.17950563968, 10365.63720269787, 10396.16830653561, 10524.894751052698, 10578.682639520826, 9990.500474976077, 10289.176865850564, 10576.20678449104, 10803.459827008775, 11115.166362522681, 9778.364406313567, 9935.900640993787, 9981.550830212513, 10159.898401016191, 10256.692299231036, 8805.924220014229, 8817.16236957488, 9052.140046695553, 9107.590158442754, 9287.582058807235, 8206.425550211428, 8652.740417787476, 8781.868271975798, 8794.164554367326, 8815.471071735716], "unit": "ms", "name": "yui.html", "value": 5633.2773985094045}], "name": "dromaeo_css", "value": 6183.119519169147}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 108.0, 113.0, 112.0, 113.0, 101.0, 112.0, 113.0, 102.0], "unit": "ms", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [156.0, 139.0, 153.0, 167.0, 131.0, 151.0, 166.0, 134.0, 174.0, 134.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.5}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 162.0, 162.0, 160.0, 161.0, 164.0, 164.0, 163.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [72.0, 77.0, 76.0, 96.0, 72.0, 72.0, 73.0, 84.0, 93.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 78.9}, {"lowerIsBetter": true, "replicates": [94.0, 100.0, 136.0, 93.0, 95.0, 94.0, 137.0, 94.0, 93.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 70.0, 71.0, 70.0, 70.0, 70.0, 72.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 70.1}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 69.0, 69.0, 68.0, 69.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 85.0, 85.0, 88.0, 83.0, 83.0, 87.0, 86.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [128.0, 127.0, 128.0, 120.0, 120.0, 121.0, 126.0, 128.0, 121.0, 131.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 149.0, 146.0, 146.0, 147.0, 148.0, 149.0, 146.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.1}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 71.0, 69.0, 68.0, 70.0, 69.0, 69.0, 67.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1524.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.371258475277], "unit": "score", "name": "Richards", "value": 213.47119400000008}, {"lowerIsBetter": false, "replicates": [192.41870309794112], "unit": "score", "name": "DeltaBlue", "value": 343.61524600000007}, {"lowerIsBetter": false, "replicates": [278.78449958182324], "unit": "score", "name": "Encrypt", "value": 954.7912470000005}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [2020.20202020202], "unit": "score", "name": "RayTrace", "value": 366.2945550000002}, {"lowerIsBetter": false, "replicates": [799.3605115907275], "unit": "score", "name": "Earley", "value": 833.7452129999997}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [26205.128205128207], "unit": "score", "name": "RegExp", "value": 34.76361545988257}, {"lowerIsBetter": false, "replicates": [622.5124378109452], "unit": "score", "name": "Splay", "value": 130.9066213786214}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19652.500133858444}]} 05:41:58 INFO - RETURN: dromaeo_css: 6183.12 05:41:58 INFO - RETURN: kraken: 1524.50 05:41:58 INFO - RETURN: v8_7: 19652.50 05:41:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19652.50"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1524.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6183.12"}}} 05:41:58 INFO - Return code: 0 05:41:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:41:58 INFO - # TBPL SUCCESS # 05:41:58 INFO - Running post-action listener: _resource_record_post_action 05:41:58 INFO - Running post-run listener: _resource_record_post_run 05:41:59 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 10285056; Write bytes: 406937600; Read time: 2992; Write time: 424156 05:41:59 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 2289664; Read time: 0; Write time: 148 05:41:59 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 8261632; Write bytes: 372391936; Read time: 2796; Write time: 414420 05:41:59 INFO - Running post-run listener: _upload_blobber_files 05:41:59 INFO - Blob upload gear active. 05:41:59 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:41:59 INFO - Copying logs to upload dir... 05:41:59 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.319983 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-26 05:41:59.976212) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 05:41:59.979486) ========= 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=e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009947 build_url: 'https://queue.taskcluster.net/v1/task/2MSNYsXGTFyGv6jcnZ-Xpg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 05:42:00.035478) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 05:42:00.035939) ========= 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=e10134013339c31d8d0c4708000001d6-1448543040.477239-1582392887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 05:42:00.088778) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 05:42:00.089411) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 05:42:00.089937) ========= ========= Total master_lag: 0.24 =========