builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-034 starttime: 1448065858.18 results: success (0) buildid: 20151120144638 builduid: b10eb016d3974000aaa3c480f91b874d revision: 809ef65b4a96cfb02ef3acfdb664fa03394a0195 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 16:30:58.184398) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 16:30:58.184858) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 16:30:58.185192) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006459 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 16:30:58.205704) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 16:30:58.206030) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 16:30:58.213616) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:30:58.213941) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004679 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:30:58.262620) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:30:58.262921) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:30:58.263267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:30:58.263554) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 16:30:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2015-11-20 16:30:58 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.236570 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:30:58.512463) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:30:58.512836) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022850 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:30:58.562731) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 16:30:58.563179) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 809ef65b4a96cfb02ef3acfdb664fa03394a0195 --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 809ef65b4a96cfb02ef3acfdb664fa03394a0195 --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=d16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 16:30:58,730 truncating revision to first 12 chars 2015-11-20 16:30:58,730 Setting DEBUG logging. 2015-11-20 16:30:58,730 attempt 1/10 2015-11-20 16:30:58,731 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/809ef65b4a96?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 16:30:59,541 unpacking tar archive at: fx-team-809ef65b4a96/testing/mozharness/ program finished with exit code 0 elapsedTime=1.107772 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 16:30:59.683617) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 16:30:59.683949) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 16:30:59.690609) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 16:30:59.690881) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 16:30:59.691253) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-20 16:30:59.691559) ========= /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=d16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:30:59 INFO - MultiFileLogger online at 20151120 16:30:59 in /builds/slave/test 16:30:59 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 16:30:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:30:59 INFO - {'append_to_log': False, 16:30:59 INFO - 'base_work_dir': '/builds/slave/test', 16:30:59 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:30:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:30:59 INFO - 'branch': 'Fx-Team-Non-PGO', 16:30:59 INFO - 'buildbot_json_path': 'buildprops.json', 16:30:59 INFO - 'config_files': ('talos/linux_config.py',), 16:30:59 INFO - 'default_actions': ('clobber', 16:30:59 INFO - 'read-buildbot-config', 16:30:59 INFO - 'download-and-extract', 16:30:59 INFO - 'populate-webroot', 16:30:59 INFO - 'create-virtualenv', 16:30:59 INFO - 'install', 16:30:59 INFO - 'run-tests'), 16:30:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:30:59 INFO - 'download_minidump_stackwalk': True, 16:30:59 INFO - 'download_symbols': 'ondemand', 16:30:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:30:59 INFO - 'tooltool.py': '/tools/tooltool.py', 16:30:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:30:59 INFO - '/tools/misc-python/virtualenv.py')}, 16:30:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:30:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:30:59 INFO - 'installer_path': 'installer.exe', 16:30:59 INFO - 'log_level': 'info', 16:30:59 INFO - 'log_name': 'talos', 16:30:59 INFO - 'log_to_console': True, 16:30:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:30:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:30:59 INFO - 'opt_config_files': (), 16:30:59 INFO - 'pip_index': False, 16:30:59 INFO - 'sps_profile': False, 16:30:59 INFO - 'sps_profile_interval': 0, 16:30:59 INFO - 'suite': 'dromaeojs', 16:30:59 INFO - 'system_bits': '64', 16:30:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:30:59 INFO - 'title': 'talos-linux64-ix-034', 16:30:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:30:59 INFO - 'use_talos_json': True, 16:30:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:30:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:30:59 INFO - 'work_dir': 'build'} 16:30:59 INFO - ##### 16:30:59 INFO - ##### Running clobber step. 16:30:59 INFO - ##### 16:30:59 INFO - Running pre-action listener: _resource_record_pre_action 16:30:59 INFO - Running main action method: clobber 16:30:59 INFO - rmtree: /builds/slave/test/build 16:30:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:31:00 INFO - Running post-action listener: _resource_record_post_action 16:31:00 INFO - ##### 16:31:00 INFO - ##### Running read-buildbot-config step. 16:31:00 INFO - ##### 16:31:00 INFO - Running pre-action listener: _resource_record_pre_action 16:31:00 INFO - Running main action method: read_buildbot_config 16:31:00 INFO - Using buildbot properties: 16:31:00 INFO - { 16:31:00 INFO - "properties": { 16:31:00 INFO - "buildnumber": 1117, 16:31:00 INFO - "product": "firefox", 16:31:00 INFO - "script_repo_revision": "production", 16:31:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:31:00 INFO - "repository": "", 16:31:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:31:00 INFO - "buildid": "20151120144638", 16:31:00 INFO - "slavename": "talos-linux64-ix-034", 16:31:00 INFO - "pgo_build": "False", 16:31:00 INFO - "basedir": "/builds/slave/test", 16:31:00 INFO - "project": "", 16:31:00 INFO - "platform": "ubuntu64_hw", 16:31:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:31:00 INFO - "slavebuilddir": "test", 16:31:00 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:31:00 INFO - "branch": "fx-team", 16:31:00 INFO - "repo_path": "integration/fx-team", 16:31:00 INFO - "stage_platform": "linux64", 16:31:00 INFO - "builduid": "b10eb016d3974000aaa3c480f91b874d", 16:31:00 INFO - "revision": "809ef65b4a96cfb02ef3acfdb664fa03394a0195" 16:31:00 INFO - }, 16:31:00 INFO - "sourcestamp": { 16:31:00 INFO - "repository": "", 16:31:00 INFO - "hasPatch": false, 16:31:00 INFO - "project": "", 16:31:00 INFO - "branch": "fx-team-linux64-talos", 16:31:00 INFO - "changes": [ 16:31:00 INFO - { 16:31:00 INFO - "category": null, 16:31:00 INFO - "files": [ 16:31:00 INFO - { 16:31:00 INFO - "url": null, 16:31:00 INFO - "name": "https://queue.taskcluster.net/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 16:31:00 INFO - } 16:31:00 INFO - ], 16:31:00 INFO - "repository": "", 16:31:00 INFO - "rev": "809ef65b4a96cfb02ef3acfdb664fa03394a0195", 16:31:00 INFO - "who": "kwierso@gmail.com", 16:31:00 INFO - "when": 1448064946, 16:31:00 INFO - "number": 6691315, 16:31:00 INFO - "comments": "Merge m-c to fx-team, a=merge", 16:31:00 INFO - "project": "", 16:31:00 INFO - "at": "Fri 20 Nov 2015 16:15:46", 16:31:00 INFO - "branch": "fx-team-linux64-talos", 16:31:00 INFO - "revlink": "", 16:31:00 INFO - "properties": [ 16:31:00 INFO - [ 16:31:00 INFO - "buildid", 16:31:00 INFO - "20151120144638", 16:31:00 INFO - "Change" 16:31:00 INFO - ], 16:31:00 INFO - [ 16:31:00 INFO - "builduid", 16:31:00 INFO - "b10eb016d3974000aaa3c480f91b874d", 16:31:00 INFO - "Change" 16:31:00 INFO - ], 16:31:00 INFO - [ 16:31:00 INFO - "pgo_build", 16:31:00 INFO - "False", 16:31:00 INFO - "Change" 16:31:00 INFO - ] 16:31:00 INFO - ], 16:31:00 INFO - "revision": "809ef65b4a96cfb02ef3acfdb664fa03394a0195" 16:31:00 INFO - } 16:31:00 INFO - ], 16:31:00 INFO - "revision": "809ef65b4a96cfb02ef3acfdb664fa03394a0195" 16:31:00 INFO - } 16:31:00 INFO - } 16:31:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 16:31:00 INFO - Running post-action listener: _resource_record_post_action 16:31:00 INFO - ##### 16:31:00 INFO - ##### Running download-and-extract step. 16:31:00 INFO - ##### 16:31:00 INFO - Running pre-action listener: _resource_record_pre_action 16:31:00 INFO - Running main action method: download_and_extract 16:31:00 INFO - mkdir: /builds/slave/test/build/tests 16:31:00 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')]} 16:31:00 INFO - https://queue.taskcluster.net/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:31:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/test_packages.json 16:31:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/test_packages.json 16:31:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:31:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:31:01 INFO - Downloaded 1302 bytes. 16:31:01 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:31:01 INFO - Using the following test package requirements: 16:31:01 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:31:01 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:31:01 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:01 INFO - u'jsshell-linux-x86_64.zip'], 16:31:01 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:31:01 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:31:01 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:31:01 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:31:01 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:31:01 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:31:01 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:31:01 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:01 INFO - https://queue.taskcluster.net/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:31:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:31:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:31:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/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 16:31:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/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 16:31:02 INFO - Downloaded 21339409 bytes. 16:31:02 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 16:31:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:31:02 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 16:31:03 INFO - Return code: 0 16:31:03 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 16:31: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')]} 16:31:03 INFO - https://queue.taskcluster.net/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:31:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:31:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:31:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/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 16:31:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/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 16:31:04 INFO - Downloaded 21339409 bytes. 16:31:04 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 16:31:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:31:04 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 16:31:05 INFO - Return code: 0 16:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:05 INFO - https://queue.taskcluster.net/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:31:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:31:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:31:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/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 16:31:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/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 16:31:06 INFO - Downloaded 11130997 bytes. 16:31:06 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 16:31:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:31:06 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 16:31:07 INFO - Return code: 0 16:31: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')]} 16:31:07 INFO - https://queue.taskcluster.net/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:31:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:31:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:31:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/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 16:31:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/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 16:31:09 INFO - Downloaded 55909406 bytes. 16:31:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:31:09 INFO - mkdir: /builds/slave/test/properties 16:31:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:31:09 INFO - Writing to file /builds/slave/test/properties/build_url 16:31:09 INFO - Contents: 16:31:09 INFO - build_url:https://queue.taskcluster.net/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:31:09 INFO - Running post-action listener: _resource_record_post_action 16:31:09 INFO - Running post-action listener: set_extra_try_arguments 16:31:09 INFO - ##### 16:31:09 INFO - ##### Running populate-webroot step. 16:31:09 INFO - ##### 16:31:09 INFO - Running pre-action listener: _resource_record_pre_action 16:31:09 INFO - Running main action method: populate_webroot 16:31:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:31:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:31:09 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:31:09 INFO - '../fennec_ids.txt'], 16:31:09 INFO - 'tests': ['tcheck2']}, 16:31:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:31:09 INFO - '--tppagecycles', 16:31:09 INFO - '7'], 16:31:09 INFO - 'tests': ['tsvgm']}}, 16:31:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:31:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:31:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:31:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:31:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:31:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:31:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:09 INFO - 'talos_options': ['--e10s'], 16:31:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:09 INFO - 'tests': ['damp', 'tps']}, 16:31:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:09 INFO - 'talos_options': ['--e10s'], 16:31:09 INFO - 'tests': ['damp', 'tps']}, 16:31:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:31:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:31:09 INFO - 'other': {'tests': ['a11yr', 16:31:09 INFO - 'ts_paint', 16:31:09 INFO - 'tpaint', 16:31:09 INFO - 'sessionrestore', 16:31:09 INFO - 'sessionrestore_no_auto_restore']}, 16:31:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:31:09 INFO - 'tests': ['a11yr', 16:31:09 INFO - 'ts_paint', 16:31:09 INFO - 'tpaint', 16:31:09 INFO - 'sessionrestore', 16:31:09 INFO - 'sessionrestore_no_auto_restore']}, 16:31:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:31:09 INFO - 'tests': ['a11yr', 16:31:09 INFO - 'ts_paint', 16:31:09 INFO - 'tpaint', 16:31:09 INFO - 'sessionrestore', 16:31:09 INFO - 'sessionrestore_no_auto_restore']}, 16:31:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:31:09 INFO - 'tests': ['a11yr', 16:31:09 INFO - 'ts_paint', 16:31:09 INFO - 'tpaint', 16:31:09 INFO - 'sessionrestore', 16:31:09 INFO - 'sessionrestore_no_auto_restore']}, 16:31:09 INFO - 'other_l64': {'tests': ['a11yr', 16:31:09 INFO - 'ts_paint', 16:31:09 INFO - 'tpaint', 16:31:09 INFO - 'sessionrestore', 16:31:09 INFO - 'sessionrestore_no_auto_restore']}, 16:31:09 INFO - 'other_nol64': {'tests': ['a11yr', 16:31:09 INFO - 'ts_paint', 16:31:09 INFO - 'tpaint', 16:31:09 INFO - 'sessionrestore', 16:31:09 INFO - 'sessionrestore_no_auto_restore']}, 16:31:09 INFO - 'svgr': {'tests': ['tsvgx', 16:31:09 INFO - 'tsvgr_opacity', 16:31:09 INFO - 'tart', 16:31:09 INFO - 'tscrollx', 16:31:09 INFO - 'cart']}, 16:31:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:31:09 INFO - 'tests': ['tsvgx', 16:31:09 INFO - 'tsvgr_opacity', 16:31:09 INFO - 'tart', 16:31:09 INFO - 'tscrollx', 16:31:09 INFO - 'cart']}, 16:31:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:09 INFO - 'tests': ['tp5o']}, 16:31:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:09 INFO - 'talos_options': ['--e10s'], 16:31:09 INFO - 'tests': ['tp5o']}, 16:31:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:09 INFO - 'talos_options': ['--xperf_path', 16:31:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:09 INFO - 'tests': ['tp5n']}, 16:31:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:09 INFO - 'talos_options': ['--e10s', 16:31:09 INFO - '--xperf_path', 16:31:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:09 INFO - 'tests': ['tp5n']}}, 16:31:09 INFO - 'talos.zip': {'path': '', 16:31:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:31:09 INFO - Running post-action listener: _resource_record_post_action 16:31:09 INFO - ##### 16:31:09 INFO - ##### Running create-virtualenv step. 16:31:09 INFO - ##### 16:31:09 INFO - Running pre-action listener: _resource_record_pre_action 16:31:09 INFO - Running main action method: create_virtualenv 16:31:09 INFO - Creating virtualenv /builds/slave/test/build/venv 16:31:09 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 16:31:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:31:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:31:09 INFO - Using real prefix '/usr' 16:31:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:31:09 INFO - Installing distribute.............................................................................................................................................................................................done. 16:31:11 INFO - Installing pip.................done. 16:31:11 INFO - Return code: 0 16:31:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:11 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 0x7fc66cb8ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1310900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1356b70>, '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 0x13a7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a8250>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807', '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 16:31:11 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 16:31:11 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 16:31:11 INFO - Using env: {'DISPLAY': ':0', 16:31:11 INFO - 'HOME': '/home/cltbld', 16:31:11 INFO - 'LANG': 'en_US.UTF-8', 16:31:11 INFO - 'LANGUAGE': 'en_US:en', 16:31:11 INFO - 'LOGNAME': 'cltbld', 16:31:11 INFO - 'MAIL': '/var/mail/cltbld', 16:31:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:11 INFO - 'MOZ_NO_REMOTE': '1', 16:31:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:11 INFO - 'NO_EM_RESTART': '1', 16:31:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:11 INFO - 'PWD': '/builds/slave/test', 16:31:11 INFO - 'SHELL': '/bin/bash', 16:31:11 INFO - 'SHLVL': '1', 16:31:11 INFO - 'TERM': 'linux', 16:31:11 INFO - 'TMOUT': '86400', 16:31:11 INFO - 'USER': 'cltbld', 16:31:11 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807', 16:31:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:11 INFO - '_': '/tools/buildbot/bin/python'} 16:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:12 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 16:31:12 INFO - Cleaning up... 16:31:12 INFO - Return code: 0 16:31:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:31: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')]} 16:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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')]} 16:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:12 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 0x7fc66cb8ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1310900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1356b70>, '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 0x13a7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a8250>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807', '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 16:31:12 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 16:31:12 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 16:31:12 INFO - Using env: {'DISPLAY': ':0', 16:31:12 INFO - 'HOME': '/home/cltbld', 16:31:12 INFO - 'LANG': 'en_US.UTF-8', 16:31:12 INFO - 'LANGUAGE': 'en_US:en', 16:31:12 INFO - 'LOGNAME': 'cltbld', 16:31:12 INFO - 'MAIL': '/var/mail/cltbld', 16:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:12 INFO - 'MOZ_NO_REMOTE': '1', 16:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:12 INFO - 'NO_EM_RESTART': '1', 16:31:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:12 INFO - 'PWD': '/builds/slave/test', 16:31:12 INFO - 'SHELL': '/bin/bash', 16:31:12 INFO - 'SHLVL': '1', 16:31:12 INFO - 'TERM': 'linux', 16:31:12 INFO - 'TMOUT': '86400', 16:31:12 INFO - 'USER': 'cltbld', 16:31:12 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807', 16:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:12 INFO - '_': '/tools/buildbot/bin/python'} 16:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:12 INFO - Downloading/unpacking psutil>=0.7.1 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31:13 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:31:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:31:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:31:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:14 INFO - Installing collected packages: psutil 16:31:14 INFO - Running setup.py install for psutil 16:31:14 INFO - building 'psutil._psutil_linux' extension 16:31:14 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 16:31:14 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 16:31:14 INFO - building 'psutil._psutil_posix' extension 16:31:14 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 16:31:14 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 16:31:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:14 INFO - Successfully installed psutil 16:31:14 INFO - Cleaning up... 16:31:14 INFO - Return code: 0 16:31:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc66cb8ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1310900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1356b70>, '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 0x13a7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a8250>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807', '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 16:31:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:31:14 INFO - Using env: {'DISPLAY': ':0', 16:31:14 INFO - 'HOME': '/home/cltbld', 16:31:14 INFO - 'LANG': 'en_US.UTF-8', 16:31:14 INFO - 'LANGUAGE': 'en_US:en', 16:31:14 INFO - 'LOGNAME': 'cltbld', 16:31:14 INFO - 'MAIL': '/var/mail/cltbld', 16:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:14 INFO - 'MOZ_NO_REMOTE': '1', 16:31:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:14 INFO - 'NO_EM_RESTART': '1', 16:31:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:14 INFO - 'PWD': '/builds/slave/test', 16:31:14 INFO - 'SHELL': '/bin/bash', 16:31:14 INFO - 'SHLVL': '1', 16:31:14 INFO - 'TERM': 'linux', 16:31:14 INFO - 'TMOUT': '86400', 16:31:14 INFO - 'USER': 'cltbld', 16:31:14 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807', 16:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:14 INFO - '_': '/tools/buildbot/bin/python'} 16:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:31:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:31:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:31:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:31:16 INFO - Installing collected packages: mozsystemmonitor 16:31:16 INFO - Running setup.py install for mozsystemmonitor 16:31:16 INFO - Successfully installed mozsystemmonitor 16:31:16 INFO - Cleaning up... 16:31:16 INFO - Return code: 0 16:31:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:31: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')]} 16:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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')]} 16:31:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc66cb8ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1310900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1356b70>, '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 0x13a7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a8250>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807', '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 16:31:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:31:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:31:16 INFO - Using env: {'DISPLAY': ':0', 16:31:16 INFO - 'HOME': '/home/cltbld', 16:31:16 INFO - 'LANG': 'en_US.UTF-8', 16:31:16 INFO - 'LANGUAGE': 'en_US:en', 16:31:16 INFO - 'LOGNAME': 'cltbld', 16:31:16 INFO - 'MAIL': '/var/mail/cltbld', 16:31:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:16 INFO - 'MOZ_NO_REMOTE': '1', 16:31:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:16 INFO - 'NO_EM_RESTART': '1', 16:31:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:16 INFO - 'PWD': '/builds/slave/test', 16:31:16 INFO - 'SHELL': '/bin/bash', 16:31:16 INFO - 'SHLVL': '1', 16:31:16 INFO - 'TERM': 'linux', 16:31:16 INFO - 'TMOUT': '86400', 16:31:16 INFO - 'USER': 'cltbld', 16:31:16 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807', 16:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:16 INFO - '_': '/tools/buildbot/bin/python'} 16:31:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:16 INFO - Downloading/unpacking blobuploader==1.2.4 16:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:18 INFO - Downloading blobuploader-1.2.4.tar.gz 16:31:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:31:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:31:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:31:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:31:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:19 INFO - Downloading docopt-0.6.1.tar.gz 16:31:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:31:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:31:19 INFO - Installing collected packages: blobuploader, requests, docopt 16:31:19 INFO - Running setup.py install for blobuploader 16:31:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:31:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:31:19 INFO - Running setup.py install for requests 16:31:19 INFO - Running setup.py install for docopt 16:31:19 INFO - Successfully installed blobuploader requests docopt 16:31:19 INFO - Cleaning up... 16:31:19 INFO - Return code: 0 16:31:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31: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')]} 16:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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')]} 16:31:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc66cb8ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1310900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1356b70>, '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 0x13a7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a8250>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807', '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 16:31:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:31:19 INFO - Using env: {'DISPLAY': ':0', 16:31:19 INFO - 'HOME': '/home/cltbld', 16:31:19 INFO - 'LANG': 'en_US.UTF-8', 16:31:19 INFO - 'LANGUAGE': 'en_US:en', 16:31:19 INFO - 'LOGNAME': 'cltbld', 16:31:19 INFO - 'MAIL': '/var/mail/cltbld', 16:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:19 INFO - 'MOZ_NO_REMOTE': '1', 16:31:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:19 INFO - 'NO_EM_RESTART': '1', 16:31:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:19 INFO - 'PWD': '/builds/slave/test', 16:31:19 INFO - 'SHELL': '/bin/bash', 16:31:19 INFO - 'SHLVL': '1', 16:31:19 INFO - 'TERM': 'linux', 16:31:19 INFO - 'TMOUT': '86400', 16:31:19 INFO - 'USER': 'cltbld', 16:31:19 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807', 16:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:19 INFO - '_': '/tools/buildbot/bin/python'} 16:31:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:20 INFO - Running setup.py (path:/tmp/pip-JIXEDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:20 INFO - Running setup.py (path:/tmp/pip-RVGl1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:20 INFO - Running setup.py (path:/tmp/pip-SZ945U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:20 INFO - Running setup.py (path:/tmp/pip-q_2Uur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:20 INFO - Running setup.py (path:/tmp/pip-GzbaGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:20 INFO - Running setup.py (path:/tmp/pip-t7r_fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:20 INFO - Running setup.py (path:/tmp/pip-HUOhoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:20 INFO - Running setup.py (path:/tmp/pip-HKEQTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:20 INFO - Running setup.py (path:/tmp/pip-Ji1PaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:20 INFO - Running setup.py (path:/tmp/pip-4G2ono-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:20 INFO - Running setup.py (path:/tmp/pip-eDSrxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:20 INFO - Running setup.py (path:/tmp/pip-8rtcEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:20 INFO - Running setup.py (path:/tmp/pip-T00dQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:21 INFO - Running setup.py (path:/tmp/pip-p9s6vE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:21 INFO - Running setup.py (path:/tmp/pip-sV9tXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:21 INFO - Running setup.py (path:/tmp/pip-e06Zxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:21 INFO - Running setup.py (path:/tmp/pip-4D0vck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:31:21 INFO - Running setup.py install for manifestparser 16:31:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:31:21 INFO - Running setup.py install for mozcrash 16:31:21 INFO - Running setup.py install for mozdebug 16:31:21 INFO - Running setup.py install for mozdevice 16:31:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:31:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:31:21 INFO - Running setup.py install for mozfile 16:31:21 INFO - Running setup.py install for mozhttpd 16:31:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:31:21 INFO - Running setup.py install for mozinfo 16:31:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:31:21 INFO - Running setup.py install for mozInstall 16:31:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:31:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:31:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:31:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:31:22 INFO - Running setup.py install for mozleak 16:31:22 INFO - Running setup.py install for mozlog 16:31:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:31:22 INFO - Running setup.py install for moznetwork 16:31:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:31:22 INFO - Running setup.py install for mozprocess 16:31:22 INFO - Running setup.py install for mozprofile 16:31:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:31:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:31:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:31:22 INFO - Running setup.py install for mozrunner 16:31:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:31:22 INFO - Running setup.py install for mozscreenshot 16:31:22 INFO - Running setup.py install for moztest 16:31:22 INFO - Running setup.py install for mozversion 16:31:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:31:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:31:23 INFO - Cleaning up... 16:31:23 INFO - Return code: 0 16:31:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc66cb8ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1310900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1356b70>, '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 0x13a7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a8250>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807', '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 16:31:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:31:23 INFO - Using env: {'DISPLAY': ':0', 16:31:23 INFO - 'HOME': '/home/cltbld', 16:31:23 INFO - 'LANG': 'en_US.UTF-8', 16:31:23 INFO - 'LANGUAGE': 'en_US:en', 16:31:23 INFO - 'LOGNAME': 'cltbld', 16:31:23 INFO - 'MAIL': '/var/mail/cltbld', 16:31:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:23 INFO - 'MOZ_NO_REMOTE': '1', 16:31:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:23 INFO - 'NO_EM_RESTART': '1', 16:31:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:23 INFO - 'PWD': '/builds/slave/test', 16:31:23 INFO - 'SHELL': '/bin/bash', 16:31:23 INFO - 'SHLVL': '1', 16:31:23 INFO - 'TERM': 'linux', 16:31:23 INFO - 'TMOUT': '86400', 16:31:23 INFO - 'USER': 'cltbld', 16:31:23 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807', 16:31:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:23 INFO - '_': '/tools/buildbot/bin/python'} 16:31:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:23 INFO - Running setup.py (path:/tmp/pip-r7Gsho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:23 INFO - Running setup.py (path:/tmp/pip-Dqcshd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:23 INFO - Running setup.py (path:/tmp/pip-n3RhLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:23 INFO - Running setup.py (path:/tmp/pip-Qlw1e8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:23 INFO - Running setup.py (path:/tmp/pip-wOsNBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:23 INFO - Running setup.py (path:/tmp/pip-nkR_CB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:23 INFO - Running setup.py (path:/tmp/pip-UYLY5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:23 INFO - Running setup.py (path:/tmp/pip-EGewSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:23 INFO - Running setup.py (path:/tmp/pip-7bU492-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:23 INFO - Running setup.py (path:/tmp/pip-JTQhE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 16:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:24 INFO - Running setup.py (path:/tmp/pip-vQArcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:24 INFO - Running setup.py (path:/tmp/pip-jNocIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:24 INFO - Running setup.py (path:/tmp/pip-j5MM7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:24 INFO - Running setup.py (path:/tmp/pip-XlaK0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:24 INFO - Running setup.py (path:/tmp/pip-oT225y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:24 INFO - Running setup.py (path:/tmp/pip-xbjdQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:24 INFO - Running setup.py (path:/tmp/pip-5Kgv9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:31:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:26 INFO - Downloading blessings-1.5.1.tar.gz 16:31:26 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 16:31:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:31:26 INFO - Installing collected packages: blessings 16:31:26 INFO - Running setup.py install for blessings 16:31:26 INFO - Successfully installed blessings 16:31:26 INFO - Cleaning up... 16:31:26 INFO - Return code: 0 16:31:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:31:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:26 INFO - Reading from file tmpfile_stdout 16:31:26 INFO - Current package versions: 16:31:26 INFO - argparse == 1.2.1 16:31:26 INFO - blessings == 1.5.1 16:31:26 INFO - blobuploader == 1.2.4 16:31:26 INFO - docopt == 0.6.1 16:31:26 INFO - manifestparser == 1.1 16:31:26 INFO - mozInstall == 1.12 16:31:26 INFO - mozcrash == 0.16 16:31:26 INFO - mozdebug == 0.1 16:31:26 INFO - mozdevice == 0.47 16:31:26 INFO - mozfile == 1.2 16:31:26 INFO - mozhttpd == 0.7 16:31:26 INFO - mozinfo == 0.9 16:31:26 INFO - mozleak == 0.1 16:31:26 INFO - mozlog == 3.0 16:31:26 INFO - moznetwork == 0.27 16:31:26 INFO - mozprocess == 0.22 16:31:26 INFO - mozprofile == 0.27 16:31:26 INFO - mozrunner == 6.11 16:31:26 INFO - mozscreenshot == 0.1 16:31:26 INFO - mozsystemmonitor == 0.0 16:31:26 INFO - moztest == 0.7 16:31:26 INFO - mozversion == 1.4 16:31:26 INFO - psutil == 3.1.1 16:31:26 INFO - requests == 1.2.3 16:31:26 INFO - wsgiref == 0.1.2 16:31:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc66cb8ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1310900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1356b70>, '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 0x13a7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a8250>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807', '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 16:31:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:31:26 INFO - Using env: {'DISPLAY': ':0', 16:31:26 INFO - 'HOME': '/home/cltbld', 16:31:26 INFO - 'LANG': 'en_US.UTF-8', 16:31:26 INFO - 'LANGUAGE': 'en_US:en', 16:31:26 INFO - 'LOGNAME': 'cltbld', 16:31:26 INFO - 'MAIL': '/var/mail/cltbld', 16:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:26 INFO - 'MOZ_NO_REMOTE': '1', 16:31:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:26 INFO - 'NO_EM_RESTART': '1', 16:31:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:26 INFO - 'PWD': '/builds/slave/test', 16:31:26 INFO - 'SHELL': '/bin/bash', 16:31:26 INFO - 'SHLVL': '1', 16:31:26 INFO - 'TERM': 'linux', 16:31:26 INFO - 'TMOUT': '86400', 16:31:26 INFO - 'USER': 'cltbld', 16:31:26 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807', 16:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:26 INFO - '_': '/tools/buildbot/bin/python'} 16:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:31:26 INFO - Cleaning up... 16:31:26 INFO - Return code: 0 16:31:26 INFO - Running post-action listener: _resource_record_post_action 16:31:26 INFO - Running post-action listener: _start_resource_monitoring 16:31:26 INFO - Starting resource monitoring. 16:31:26 INFO - ##### 16:31:26 INFO - ##### Running install step. 16:31:26 INFO - ##### 16:31:26 INFO - Running pre-action listener: _resource_record_pre_action 16:31:26 INFO - Running main action method: install 16:31:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:27 INFO - Reading from file tmpfile_stdout 16:31:27 INFO - Detecting whether we're running mozinstall >=1.0... 16:31:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:31:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:31:27 INFO - Reading from file tmpfile_stdout 16:31:27 INFO - Output received: 16:31:27 INFO - Usage: mozinstall [options] installer 16:31:27 INFO - Options: 16:31:27 INFO - -h, --help show this help message and exit 16:31:27 INFO - -d DEST, --destination=DEST 16:31:27 INFO - Directory to install application into. [default: 16:31:27 INFO - "/builds/slave/test"] 16:31:27 INFO - --app=APP Application being installed. [default: firefox] 16:31:27 INFO - mkdir: /builds/slave/test/build/application 16:31:27 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'] 16:31:27 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 16:31:41 INFO - Reading from file tmpfile_stdout 16:31:41 INFO - Output received: 16:31:41 INFO - /builds/slave/test/build/application/firefox/firefox 16:31:41 INFO - Running post-action listener: _resource_record_post_action 16:31:41 INFO - ##### 16:31:41 INFO - ##### Running run-tests step. 16:31:41 INFO - ##### 16:31:41 INFO - Running pre-action listener: _resource_record_pre_action 16:31:41 INFO - Running main action method: run_tests 16:31:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:31:41 INFO - Python 2.7.3 16:31:41 INFO - Return code: 0 16:31:41 INFO - grabbing minidump binary from tooltool 16:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:41 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 0x1356b70>, '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 0x13a7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a8250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:31:41 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 16:31:41 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 16:31:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:31:41 INFO - Return code: 0 16:31:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:31:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:31:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:31:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:31:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:31:41 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/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] in /builds/slave/test/build 16:31:41 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/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost 16:31:41 INFO - Using env: {'DISPLAY': ':0', 16:31:41 INFO - 'HOME': '/home/cltbld', 16:31:41 INFO - 'LANG': 'en_US.UTF-8', 16:31:41 INFO - 'LANGUAGE': 'en_US:en', 16:31:41 INFO - 'LOGNAME': 'cltbld', 16:31:41 INFO - 'MAIL': '/var/mail/cltbld', 16:31:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:31:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:41 INFO - 'MOZ_NO_REMOTE': '1', 16:31:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:41 INFO - 'NO_EM_RESTART': '1', 16:31:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:41 INFO - 'PWD': '/builds/slave/test', 16:31:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:31:41 INFO - 'SHELL': '/bin/bash', 16:31:41 INFO - 'SHLVL': '1', 16:31:41 INFO - 'TERM': 'linux', 16:31:41 INFO - 'TMOUT': '86400', 16:31:41 INFO - 'USER': 'cltbld', 16:31:41 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807', 16:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:41 INFO - '_': '/tools/buildbot/bin/python'} 16:31:41 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/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] with output_timeout 3600 16:31:41 INFO - mozversion INFO | application_buildid: 20151120144638 16:31:41 INFO - mozversion INFO | application_changeset: 809ef65b4a96cfb02ef3acfdb664fa03394a0195 16:31:41 INFO - mozversion INFO | application_display_name: Nightly 16:31:41 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:31:41 INFO - mozversion INFO | application_name: Firefox 16:31:41 INFO - mozversion INFO | application_remotingname: firefox 16:31:41 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:31:41 INFO - mozversion INFO | application_vendor: Mozilla 16:31:41 INFO - mozversion INFO | application_version: 45.0a1 16:31:41 INFO - mozversion INFO | platform_buildid: 20151120144638 16:31:41 INFO - mozversion INFO | platform_changeset: 809ef65b4a96cfb02ef3acfdb664fa03394a0195 16:31:41 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:31:41 INFO - mozversion INFO | platform_version: 45.0a1 16:31:41 INFO - 2015-11-20 16:31:41,517 DEBUG : using testdate: 1448065901 16:31:41 INFO - 2015-11-20 16:31:41,517 DEBUG : actual date: 1448065901 16:31:41 INFO - 2015-11-20 16:31:41,533 INFO : starting webserver on 'localhost:48887' 16:31:41 INFO - 2015-11-20 16:31:41,534 INFO : Starting test suite talos-linux64-ix-034 16:31:41 INFO - 2015-11-20 16:31:41,534 INFO : Starting test dromaeo_css 16:31:41 INFO - 2015-11-20 16:31:41,534 DEBUG : operating with platform_type : linux_ 16:31:41 INFO - 2015-11-20 16:31:41,535 INFO : Initialising browser for dromaeo_css test... 16:31:41 INFO - 2015-11-20 16:31:41,548 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHUBwAw/profile http://localhost:48887/getInfo.html 16:31:46 INFO - 2015-11-20 16:31:46,784 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:31:46 INFO - 2015-11-20 16:31:46,784 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:31:46 INFO - 2015-11-20 16:31:46,784 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:31:46 INFO - 2015-11-20 16:31:46,784 DEBUG : BROWSER_OUTPUT: __metrics 16:31:46 INFO - 2015-11-20 16:31:46,893 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:31:48 INFO - 2015-11-20 16:31:48,468 INFO : Browser initialized. 16:31:48 INFO - 2015-11-20 16:31:48,469 INFO : Running cycle 1/1 for dromaeo_css test... 16:31:48 INFO - 2015-11-20 16:31:48,469 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHUBwAw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:32:00 INFO - 2015-11-20 16:32:00,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 141897728 16:32:00 INFO - 2015-11-20 16:32:00,395 DEBUG : BROWSER_OUTPUT: 16:32:51 INFO - 2015-11-20 16:32:51,948 DEBUG : BROWSER_OUTPUT: 1448065971943 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] 16:35:04 INFO - 2015-11-20 16:35:04,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48887/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48887/tests/dromaeo/cssquery-ext.html) 16:35:05 INFO - 2015-11-20 16:35:05,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 250314752 16:35:05 INFO - 2015-11-20 16:35:05,446 DEBUG : BROWSER_OUTPUT: 16:38:07 INFO - 2015-11-20 16:38:07,873 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48887/tests/dromaeo/cssquery-ext.html (next: http://localhost:48887/tests/dromaeo/cssquery-jquery.html) 16:38:08 INFO - 2015-11-20 16:38:08,455 DEBUG : BROWSER_OUTPUT: RSS: Main: 220368896 16:38:08 INFO - 2015-11-20 16:38:08,455 DEBUG : BROWSER_OUTPUT: 16:41:10 INFO - 2015-11-20 16:41:10,497 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48887/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48887/tests/dromaeo/cssquery-mootools.html) 16:41:11 INFO - 2015-11-20 16:41:11,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 221732864 16:41:11 INFO - 2015-11-20 16:41:11,079 DEBUG : BROWSER_OUTPUT: 16:44:13 INFO - 2015-11-20 16:44:13,055 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48887/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48887/tests/dromaeo/cssquery-prototype.html) 16:44:13 INFO - 2015-11-20 16:44:13,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 205209600 16:44:13 INFO - 2015-11-20 16:44:13,642 DEBUG : BROWSER_OUTPUT: 16:47:16 INFO - 2015-11-20 16:47:16,468 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48887/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48887/tests/dromaeo/cssquery-yui.html) 16:47:17 INFO - 2015-11-20 16:47:17,095 DEBUG : BROWSER_OUTPUT: RSS: Main: 203259904 16:47:17 INFO - 2015-11-20 16:47:17,095 DEBUG : BROWSER_OUTPUT: 16:50:19 INFO - 2015-11-20 16:50:19,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48887/tests/dromaeo/cssquery-yui.html (next: http://localhost:48887/tests/dromaeo/cssquery-dojo.html) 16:50:19 INFO - 2015-11-20 16:50:19,906 DEBUG : BROWSER_OUTPUT: RSS: Main: 229867520 16:50:19 INFO - 2015-11-20 16:50:19,906 DEBUG : BROWSER_OUTPUT: 16:50:19 INFO - 2015-11-20 16:50:19,907 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:50:19 INFO - 2015-11-20 16:50:19,907 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:50:19 INFO - 2015-11-20 16:50:19,908 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:50:19 INFO - 2015-11-20 16:50:19,908 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:50:19 INFO - 2015-11-20 16:50:19,911 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2639.564471862143;2732.494488519624;2735.4802587508384;2738.6165936768843;2747.477979183955;4493.752843593601;4626.583607475327;4633.235516139837;4670.719756814589;4689.507601701824;4581.954180458194;4632.444106707191;4708.929366059503;4709.929351059737;4721.598664113554;4320.546342634026;4384.364267181257;4401.977990110045;4406;4421.09367579647;4184.644305234059;4390.517043125254;4411.823527058914;4440.400545926307;4449.4660640723;4152.397902304149;4223.788810559459;4262.680298977589;4288.506821715511;4304.225239456897;4332.761698106603;4333.479982402132;4334.566543345672;4342.066455712037;4386.758728269944;4166.375043743433;4256.425382573375;4303.784810759481;4313.805878735465;4344.326629372421;4543.977280113579;4565.794539245742;4641.3270075839155;4663.393758811367;4686.742229177394;5095.261187127846;5098.97450512745;5122.564582010496;5140.254663073871;5163.741812909339;4838.516148385169;4952.059108769322;5125.256837758504;5138.974305128488;5147.176451767737;4567.611753001032;4614.907701845944;4645.187092258909;4648.86053418398;4700.835470758507;5183.196604526304;5212.270282160424;5232.372115346183;5235.921461178085;5267.841964741064;4727.905441891143;4836.250381190921;4993.875153121201;5005.374328208974;5008.323876276656;4875.122477953932;4928.507149285115;4969.701817890938;4972.801087956514;4990.950090499121;5006.3992320921;5009;5010.048090862724;5018.146915024455;5049.091163590589;4734.337192793012;4844.636652251095;4975.353204083446;4978.90042199154;5025.3718285214345;4071.8371265149653;4124.340105583093;4140.213359461693;4155.97922010388;4160.854370097032;3720.6465385788306;3724.0131365188245;3729.21686445844;3730.403135498307;3761.492198553215;4168.937465938014;4373;4379.211741886491;4385.693001489929;4429.889252768707;4943.307936888838;4968.950310496849;5008.474110218447;5123.666961647481;5139.794408223704;4347.652187824967;4348.67384946124;4364.083542456056;4364.869053928387;4403.075354175595;4493.236149854532;4498.775061246924;4504.729716217037;4506.842260520866;4548.249538826123;4564.977175114103;4676.345311656439;4686.812527498998;4754.286856971482;4859.392575927938;5154.561862241601;5157.458466860926;5158.767855446589;5162.819301324435;5183.300254465599;4869.074875773592;4869.878253043702;4877.512248775094;4883.682560633548;4913.164761990399;4709.4584122824945;4816.95183048165;4824.782884770124;4888.706677599355;5075.593952483866;5079.415867175322;5082.3138876252715;5082.847514574569;5084.135696931605;5091;4898.4121905371585;4902.068606964808;4902.681325713817;4905.3623029006;4946.183879659816;4619.538046195354;4754.500777418321;4758.7858546364805;4833.275008748576;4950.603951683928;4804.855854324376;4822.445418776885;4826.686265392738;4862.781174847211;4874.561289483963;4934.679245849008;4937;4940.530649588283;4941.2835138905375;4981.37732783402;4551.681382303207;4655.976720116378;4666.719996800203;4827.444843843003;4833.685810422311 16:50:19 INFO - 2015-11-20 16:50:19,911 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.4992481728852;566.0914232656588;570.4438172781537;572.2703552969964;574.9568782341325;28334.149975500743;28824;28913.421731565355;28917.421651566983;36709;40314.59685403145;40884.38673419894;40944.79527602365;41034.58965410345;41046.58953410465;7846.607669616525;8018.67925282988;8022.277994980451;8023.39824513161;8028.0767711713315;7084.787456376317;7267.563946163247;7269.527480713763;7269.672864721074;7892.881606775903;7044.506884518086;7108.537945033582;9851.753706157368;10058.647947321846;10065;9722.854157187649;9818.410895346302;9820.90179098207;9836.754081147958;9863.457509836957;7043.436525077981;9691.0617876425;9822.557984890696;9832.705018849447;9832.901670983341;28248.576271355945;41731.582684173074;42796;42802.35796463056;42812.57187428117;2864.5130327844317;2892.7251911068415;2914.9125526234034;2928.546075358323;3628.11111277736;28083.157505274874;28282.717172828216;28284.71715282862;28298.858505707547;28909;3315.370079684852;3383.226372224672;3418.6410426905313;3504.632013638582;3549.0240183949363;203769;203903;204853;205164.97417512967;205451;53475.19787203195;53660;53775.19337209945;53788.46211537913;53843.73078134584;56297.71851140718;56469;56542.43457565454;56705.14942275869;56765.43234567602;13199.538016169388;13427.865721342858;13567.932160339134;13573;13600.115992460458;9114;9137.77155571116;9146.2682985361;9146.679866204784;9150.222231110298;18803.623927521374;18850.434486965412;19146;19208.903955480135;19214;7542.660580273791;7903.802404939807;7935.960320198362;7966.681332746741;7966.888774474769;765.559803113201;808.2887059387701;954.5418199264253;969.3505351414569;972.601233494264;25322.493550128893;25503.744962550136;25529.489410212063;25629.48741025169;25644;893.8972018217988;903.3495882964387;906.2795077913075;929.2194556572512;942.5098948546718;12079.879201208052;12293.815592766116;12337;12827.422765975554;15099.924500377429;272132;281435;281740;282421;282601;49241.26138107931;49443.50556494389;49551.256731149064;49621.25568116481;49626.50373496291;1143.3768596115137;1166.2827361172817;1181.5982565927454;1199.580146948561;1199.9700007499707;27449;27975.860120699268;28371.038704013976;28492.715072849005;28686.282842929093;41601.1679766409;41914;42055;42110;42116;265527;268851;269348;269386;269498;24699.876500618102;25039.624405633567;25129.623055654545;25214;25358.239252822445;34796.82601586976;35177.29645407027;35757.46363804493;35806.283874321845;35968.28063438664;30436.695633044274;32458;33134;33774.32451351008;33920.83039584885;33433.83283083666;33882.152946176546;33884.49173262354;34109;34379;32989.83505082459;33351.332973339915;33666.49500257449;33739.662603373654;33838;28455.146345609664;29175.562366564092;29786.553201701558;29865.104046878627;30029.69970300269;23057.769422305562;23660.17189398363;23830.88084559566;23982.28053158408;24006.27981160568 16:50:19 INFO - 2015-11-20 16:50:19,911 DEBUG : BROWSER_OUTPUT: |2;jquery.html;327.6674175711653;331.19498731911085;333.3433136720661;335.0467918771095;337.22438391699086;12491.687707807308;12929.870701292984;14924.925375373121;15337.156456394894;15888.205589720512;9779.217662586994;10019.499025048737;10037.046480584351;15081.170535620537;15280.159591222478;4567.520410356915;4684.906301873961;4694.906101877978;4697.67116301859;4707.505711900252;3902.083010492532;3999.960000399988;6220.751169953196;6529.902051469232;6821.249662537117;6627.900581491257;6704.564203326792;6749.93250067498;6775.9661201693925;6789.626570538619;6713.328667133296;6748.797536073926;6790;6790.253072162058;6795.762148324785;6376.521760867907;6493.707783149723;6496.707648155844;6586.571872828251;6597.1423714916755;15512.534623961299;15560.688786224326;15570.221488925508;20494.872781996983;20605.896970515052;1884.4629280654947;1924.3457224543583;1944.6596845552112;1955.4036019014195;2014.7783743788173;13757.518486853012;13785.172889626654;13797.10318829273;14141.505047323295;14462.638434039232;1813.4922221777924;1835.2658936425403;1843.4285371534868;1897.2411035585737;1960.7451031365974;61434.38565614376;63537;64872.351276487105;65067.3493265066;65325;15276.770848437282;15320.770188447183;15401.383944642088;15407.768883466757;15408.460703875535;22774.544509110056;22883.656745148837;22977.7702222979;22994;23020.654690179326;8414.074451810297;8417.60098371961;8428.410011299273;8455.112213217524;8570.914290857012;6988.895166572505;6993.755218567326;7066.187388450291;7168.53404528704;7171.964140179266;7533.773986780406;7623.504472209289;7631.313181813553;7641.579713115832;7749.728759493503;1700.200905574378;1710.63221407398;1715.9914200428918;1721.5954250751063;2123.9168024307714;826.3182874128868;855.6021450025768;913.6847787513298;927.9814403712023;962.0908241711655;13272.933635331954;14651.633709157357;15070.924645376923;15331.156786376856;16741.49775506737;802.7431222009018;817.5054092274207;823.6869989403988;922.2714055895767;971.3297824501071;5582.190582365615;5653.265075540236;5793.102069179284;5865.061590145556;5875.706214689249;489931;502775;505298;518233;546612;68537.65731171412;69438.30561694318;69499.30500694929;70029;71259.2874071263;466.02368038958326;469.3546373736113;469.3780740518758;469.4765336649611;469.98825029373853;9968.55141518619;10143.49282535885;13975;14496.34766435534;14749.262536873328;29571.85214073916;29634.55548166736;29719.851400742857;30585.54121688132;30622.540661890536;36180.63819361878;36890;38728;39003.80498097491;39693;9223.123803238681;9297.30270229722;9428.717138485856;9465.195458386115;9469.715908522756;11880.643580692593;15403.460878869186;15778.36886524572;16353.591160221089;17047.573810654834;12630.242185468902;12975.351232438152;13372.197668139943;13438.798418023542;13572.72854542884;13150.671233219246;13279.136856104322;13473.393697283842;13558.864411356155;13660.112092713942;12751.872481275439;12806.67983300425;13271.933640331736;13374.13068150567;13881.583552493441;8629.39594228398;8838.867416988878;8977.910220897707;9008.099190080939;9011;9570.282228832726;9697.224222062077;10597.62908298206;13790.241536715577;13803.654908627364 16:50:19 INFO - 2015-11-20 16:50:19,913 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1231.2981600487724;1270.872912708729;1320.6038188543434;1425.1449130521682;1694.3815507339825;5719.170720245567;6371.362863713632;6654.367835055674;6659.600423974565;6667.166604174478;6477.417032467077;6585.736570537185;6590.571612845161;6598.736050557984;6600.570962887409;1767.1252729898717;1823.717323814811;1825.196913358125;2072.8963551822385;2101.737282839645;1775.3076300242915;1784.8215178482178;2052.548439343342;2097.7797331280226;2106.010175217653;2085.030460835711;2094.1937354118622;2094.214669498938;2098.527831237967;2098.8740675559516;2006.9162652167886;2062.896855157251;2065.0500769646055;2065.4320061982926;2067.3281183615386;2093.2464312847364;2098.548812005411;2127.393692797545;2133.7866213378693;2136.8504204705678;6821.386075253202;6879.140107486564;6883.208431030395;6890.552114112566;6912.101426814532;4077.6941729370415;4149.33610622299;4156.709030367875;4164.12553363794;4169.10364271683;2755.5728862026417;2786.8188567743236;2824.3503994081475;2834.2630915962;2840.2899275181203;918.7473444802666;934.509382574154;937.3110763588757;961.8845738511353;967.6322997260996;9035.141661542142;9043.864342034874;9051;9051.185393314567;9060.909390906072;3854.9614503854605;3948.940765888514;3986.5814089520763;3988.3219852624543;3989.740666856645;7790.454668173287;7797.80505487356;7817.140114587391;7818.14000459949;7825.334846538108;4181.60274773896;4197.433346498245;4200.453940987713;4206.49522057349;4213.5154457237195;3791.1469919268498;3792.1467669774634;3812.218495208476;3821.121142137324;3822.6750726188584;3341.231516751161;3382.5433566468705;3406.5571475707998;3433.124553238958;3439.1402149462633;924.4314746430897;984.2077127912099;1124.6794663520857;1133.4106264742288;1137.533611219396;907.3240435875315;913.2693844924034;913.7167478081816;917.6788124156492;1168.462507246659;6341.23905131378;6359.618422894641;6379.585326953733;6400.135981642512;6404.071409645575;1022.9539670714836;1032.3341444768082;1040.6773900090996;1049.8635177427038;1063.3832377221192;4970.65205435616;5092.414372347227;5093.0577843099145;5095.541401273903;5102.132637451642;7661.965634639364;7960.283574478209;8118.269355757892;8125.715599954092;8132.6746930122135;8001.319887809485;8011.95695097758;8016.519008859487;8022.197780221931;8028.197180282042;6251.718397728455;6315.894718424257;6344.6827658616885;6405.871882562323;6424.807255782241;6182.598131121463;6214.875702486015;6226.62640241587;6235.158253635701;6235.532335074979;7140.428765698835;7241.855162896607;7251.927480725125;7263.673134709056;7263.963680181565;7377.5204611700065;7457.6271186441545;7489.400847932044;7499.88750168737;7573.810654733676;6059.303180134341;6117.84705382369;6117.908231376622;6118.877622447437;6121.204243448501;5484.61607687458;6538.313477084837;6575.243846957661;6592.571482853599;6609.900851487328;5590.664560126405;5761.625494342854;5941.792037278675;6045.667488288186;6123.908141377794;6048.092786082123;6056.757729690763;6076.1493390924425;6100.938990610037;6136;6141.754329826936;6157.138000679998;6167.074938759222;6175.876482470236;6190.226221722285;5611.270534830446;5636.239107720406;5649.604527683023;5724.141378793214;5725.627834190765;5876.970615146897;5906.734196961061;5918;5919.289685237627;5922.496587789914 16:50:19 INFO - 2015-11-20 16:50:19,914 DEBUG : BROWSER_OUTPUT: |4;prototype.html;313.7725149266781;318.0282250049691;322.9289556297614;324.25583286357806;324.56022090067955;5180.274761533379;5286.629935904488;5343.438938911417;5361.490658387452;5420.91868621971;5183.17069268917;5295.602829787762;5316.627836051468;5331.600129990247;5349.144136938091;4006.959930400688;4098.7540747555095;4218.11419601884;4220.662347012247;4228;4134.214499245134;4213.662906967435;4221.978890105561;4227.915441691164;4230.534641189467;4183.811728472211;4184.8535301264465;4184.937225941613;4189.245935731567;4194.412782210493;4181.937270940938;4182.979085104555;4188.539260681323;4189.120284740208;4191.434156388909;3709.684676802475;3716.9442458363146;3719.9442008369897;3720.3675375186285;3721.5534135903863;4989.725565093919;5098.388193416777;5152.510511501401;5173.1722924331925;5192.688438693691;4788.11419887322;4788.95211047892;4792.832250871203;4795.736234507101;4800.039992001579;5420.512153906128;5548.361938377098;5683.74423150955;5694.5159661428415;5697.886042279172;3885.630865067814;3945.5659877413464;3969.4641223434755;3969.4839670842894;3971.6226958439192;5875.676837773921;5903.085021821582;5960.195373624549;5967.49276311514;5967.791127310524;4062.8171732272117;4081.714280000431;4087;4087.1008378156757;4087.89780255496;4003.2393845169327;4119.958800412018;4145.626893579592;4146.315857883415;4152.1280531088805;4691.249400095969;4739.526047395233;4742.905141897143;4744.5492678195515;4745.525447455227;5663.546916246691;5667.574931880125;5677.77288908439;5678.545716342683;5680.11958146488;1448.3192899337294;1471.5070451398901;1471.5364660132025;1472.536151112396;1472.639203395175;990.9454979976026;993.5677980078544;993.7863359377624;994.110271307176;1016.3343010328247;4954.950450495449;4964.826231081895;4967.652264341534;4967.7019378837385;4976.2286845539;5883.823485295448;5884.823455296348;5888.5289176865745;5888.823335299948;5895.734691938873;4956.207006878882;4960;4963.230699241623;4967.230079337708;4969.155243608595;3101.0916041553614;3144.2925341797913;3149.3858697554215;3165.3036332006923;3169.7939633924184;5541.251930989345;5551.694656793915;5552.111662134039;5557.41647127054;5560;6050.455459008623;6052.455279024821;6054.969725151434;6064.878702425926;6065.8180254592435;5560.555155587544;5564.1931919871395;5570.498655120978;5571.1086226203615;5574.609777315712;5660.320761508646;5698.6635479453225;5837.09525023622;5893.410658934073;5897.705114744332;5613.915791263053;5770.076787713946;5773.480386765212;5782.074868021096;5782.855428614318;5582.106862902078;5591.748371323219;5592.133219351007;5598.636088654224;5603.10350343943;4058.898527536835;4060.837566497307;4068.0846809467635;4078.1028173801715;4081.5306239781617;5730.74211660468;5877.823665290048;5905.645661260338;5917.142014407801;5946.791862284799;5678.801241956512;5702.800401985911;5710.543156547549;5713.143028545752;5721.942780572307;5706.087026075808;5706.343770466284;5710.771569137188;5711.171880077282;5714.257146571085;5438.864028399322;5558.499735023867;5576.749046293007;5585.413531579288;5589.888202236014;5695.231143795535;5736.282964629421;5748.051571490657;5749.856253593526;5757.165211044459;5617.9719101404235;5621.325440946949;5621.578381621313;5621.7189140542;5631.155326700864 16:50:19 INFO - 2015-11-20 16:50:19,914 DEBUG : BROWSER_OUTPUT: |5;yui.html;650.3236633900742;713.0373995106606;740.4076738609111;745.5228653661654;766.4098644044083;10034.698959031222;10204.948975255124;10211.081002709754;10223.437710925897;10241.487925603727;11060.668179954615;11110.722231944206;11133.443327833596;11134;11152.219344645859;616.6824085595922;624.0514418084509;781.4412694923129;782.9608519574027;796.7052190689424;789.5973053742575;790.8181118342785;799.8960135182418;800.747764454198;801.4149670740363;824.4476200945351;837.6816809612338;839.3243439031577;839.3243439031577;839.5130824122025;650.229478068488;658.2758965138333;811.4968719393954;824.8185399212164;827.664795757719;606.4208680709911;611.7828170999276;612.6385432594791;612.702839123025;612.9846753831146;11133.944330278378;11178.552857885676;11182.944085279603;11230.438478076063;11241.83137252942;10465.162786977024;11136.164787640959;11207.66377008691;11298.943505282503;11353.772924541545;8874.112588741138;8925.330600204945;9357.111074447917;9605.759856003586;9681.419114853132;3150.952735708966;3266.526353678727;3267.18320419895;3273.165342837585;3296.604407471119;39488.80255598732;39502.802485987675;39525;39578.40632390545;39740.801295993624;9266.490343031062;9372.1565059145;9411.811763764686;9691.70924872255;9783.510824458748;16613.41853035138;16637.168141592872;16638.417655382247;16660.833391666172;16662.08358540292;6243.469305109116;6299.496040316855;6314.810555683245;6415.326390728999;6684.899726504106;3575.7318201135017;3618.620044895301;3646.3801153803915;3662.505561749183;3699.389600715852;2715.7963152763623;2739.000264903296;2740.671119465677;2746.931326716848;2749.1065403743864;491.8967016926414;493.83456542058093;506.0839879817542;506.25074889164244;507.710604955172;491.9237518184687;550.5017958747341;581.1050981488545;592.762894842058;615.7906311853991;7755.573443460551;7833.843323133506;7904.960475197702;8032.277095061356;8043.826697961916;578.9363170051291;596.7911231069178;597.8146774499832;609.071166471135;628.5945565110478;3706.777593344408;3714.1643130295465;3749.9437508437395;3890.6109389061435;3893.0656642406184;48863.26705099426;49563.50436495661;49570.25644615333;49641;49706;46575.53424465712;46809;46879;47151.5284847154;47239.76380118077;40646.79676601598;40969.79515102465;40993.1801363977;41763.7911810439;42267.788661057115;8033.959830200812;8297.834043318979;8311.750647480585;8420.242178203991;8578;29641.25896852596;30263.697363026968;30543.694563054087;30654.233644158183;30860.382792344477;35227;35574.288514229054;38550.42174367331;39146.2170756589;39250.41124383079;9436.292278079034;9531.952340238255;9736.075072868067;10014.3490673106;10164.491775411348;11210.887891120985;11320.886791131983;11710.355930423568;11748.29510229389;11795.882041179822;9968.847352024923;9984.850227246452;10229.590816367261;10230.437325947145;10258.692239232834;10083.344582602107;10307.896921030693;10355.378677279386;10391.948040259751;10680.57277708883;10109.34289271195;10240.334378265388;10314.935581358526;10421.843672345072;10714.946425267824;9227.30795190377;9304.534773261175;9338.626454941726;9578;9713.902860971582;9153.588088536166;9193;9311.603259511128;9320.766980825534;9561.426314420878 16:50:19 INFO - 2015-11-20 16:50:19,914 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:50:19 INFO - 2015-11-20 16:50:19,914 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:50:19 INFO - 2015-11-20 16:50:19,914 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,999 16:50:19 INFO - 2015-11-20 16:50:19,914 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:50:19 INFO - 2015-11-20 16:50:19,914 DEBUG : BROWSER_OUTPUT: __startTimestamp1448067019907__endTimestamp 16:50:19 INFO - 2015-11-20 16:50:19,914 DEBUG : BROWSER_OUTPUT: 16:50:19 INFO - 2015-11-20 16:50:19,915 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:50:19 INFO - 2015-11-20 16:50:19,915 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:50:19 INFO - 2015-11-20 16:50:19,915 DEBUG : BROWSER_OUTPUT: 16:50:19 INFO - 2015-11-20 16:50:19,915 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4639.23 Median:4721.60 stddev:484.53 (10.3%) stddev-sans-first:459.93 16:50:19 INFO - 2015-11-20 16:50:19,916 DEBUG : BROWSER_OUTPUT: Values: 2639.6 2732.5 2735.5 2738.6 2747.5 4493.8 4626.6 4633.2 4670.7 4689.5 4582.0 4632.4 4708.9 4709.9 4721.6 4320.5 4384.4 4402.0 4406.0 4421.1 4184.6 4390.5 4411.8 4440.4 4449.5 4152.4 4223.8 4262.7 4288.5 4304.2 4332.8 4333.5 4334.6 4342.1 4386.8 4166.4 4256.4 4303.8 4313.8 4344.3 4544.0 4565.8 4641.3 4663.4 4686.7 5095.3 5099.0 5122.6 5140.3 5163.7 4838.5 4952.1 5125.3 5139.0 5147.2 4567.6 4614.9 4645.2 4648.9 4700.8 5183.2 5212.3 5232.4 5235.9 5267.8 4727.9 4836.3 4993.9 5005.4 5008.3 4875.1 4928.5 4969.7 4972.8 4991.0 5006.4 5009.0 5010.0 5018.1 5049.1 4734.3 4844.6 4975.4 4978.9 5025.4 4071.8 4124.3 4140.2 4156.0 4160.9 3720.6 3724.0 3729.2 3730.4 3761.5 4168.9 4373.0 4379.2 4385.7 4429.9 4943.3 4969.0 5008.5 5123.7 5139.8 4347.7 4348.7 4364.1 4364.9 4403.1 4493.2 4498.8 4504.7 4506.8 4548.2 4565.0 4676.3 4686.8 4754.3 4859.4 5154.6 5157.5 5158.8 5162.8 5183.3 4869.1 4869.9 4877.5 4883.7 4913.2 4709.5 4817.0 4824.8 4888.7 5075.6 5079.4 5082.3 5082.8 5084.1 5091.0 4898.4 4902.1 4902.7 4905.4 4946.2 4619.5 4754.5 4758.8 4833.3 4950.6 4804.9 4822.4 4826.7 4862.8 4874.6 4934.7 4937.0 4940.5 4941.3 4981.4 4551.7 4656.0 4666.7 4827.4 4833.7 16:50:19 INFO - 2015-11-20 16:50:19,916 DEBUG : BROWSER_OUTPUT: 16:50:19 INFO - 2015-11-20 16:50:19,916 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41043.39 Median:34014.92 stddev:66111.70 (194.4%) stddev-sans-first:66227.28 16:50:19 INFO - 2015-11-20 16:50:19,916 DEBUG : BROWSER_OUTPUT: Values: 559.5 566.1 570.4 572.3 575.0 28334.1 28824.0 28913.4 28917.4 36709.0 40314.6 40884.4 40944.8 41034.6 41046.6 7846.6 8018.7 8022.3 8023.4 8028.1 7084.8 7267.6 7269.5 7269.7 7892.9 7044.5 7108.5 9851.8 10058.6 10065.0 9722.9 9818.4 9820.9 9836.8 9863.5 7043.4 9691.1 9822.6 9832.7 9832.9 28248.6 41731.6 42796.0 42802.4 42812.6 2864.5 2892.7 2914.9 2928.5 3628.1 28083.2 28282.7 28284.7 28298.9 28909.0 3315.4 3383.2 3418.6 3504.6 3549.0 203769.0 203903.0 204853.0 205165.0 205451.0 53475.2 53660.0 53775.2 53788.5 53843.7 56297.7 56469.0 56542.4 56705.1 56765.4 13199.5 13427.9 13567.9 13573.0 13600.1 9114.0 9137.8 9146.3 9146.7 9150.2 18803.6 18850.4 19146.0 19208.9 19214.0 7542.7 7903.8 7936.0 7966.7 7966.9 765.6 808.3 954.5 969.4 972.6 25322.5 25503.7 25529.5 25629.5 25644.0 893.9 903.3 906.3 929.2 942.5 12079.9 12293.8 12337.0 12827.4 15099.9 272132.0 281435.0 281740.0 282421.0 282601.0 49241.3 49443.5 49551.3 49621.3 49626.5 1143.4 1166.3 1181.6 1199.6 1200.0 27449.0 27975.9 28371.0 28492.7 28686.3 41601.2 41914.0 42055.0 42110.0 42116.0 265527.0 268851.0 269348.0 269386.0 269498.0 24699.9 25039.6 25129.6 25214.0 25358.2 34796.8 35177.3 35757.5 35806.3 35968.3 30436.7 32458.0 33134.0 33774.3 33920.8 33433.8 33882.2 33884.5 34109.0 34379.0 32989.8 33351.3 33666.5 33739.7 33838.0 28455.1 29175.6 29786.6 29865.1 30029.7 23057.8 23660.2 23830.9 23982.3 24006.3 16:50:19 INFO - 2015-11-20 16:50:19,916 DEBUG : BROWSER_OUTPUT: 16:50:19 INFO - 2015-11-20 16:50:19,916 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27514.65 Median:21797.54 stddev:83678.22 (383.9%) stddev-sans-first:83888.05 16:50:19 INFO - 2015-11-20 16:50:19,916 DEBUG : BROWSER_OUTPUT: Values: 327.7 331.2 333.3 335.0 337.2 12491.7 12929.9 14924.9 15337.2 15888.2 9779.2 10019.5 10037.0 15081.2 15280.2 4567.5 4684.9 4694.9 4697.7 4707.5 3902.1 4000.0 6220.8 6529.9 6821.2 6627.9 6704.6 6749.9 6776.0 6789.6 6713.3 6748.8 6790.0 6790.3 6795.8 6376.5 6493.7 6496.7 6586.6 6597.1 15512.5 15560.7 15570.2 20494.9 20605.9 1884.5 1924.3 1944.7 1955.4 2014.8 13757.5 13785.2 13797.1 14141.5 14462.6 1813.5 1835.3 1843.4 1897.2 1960.7 61434.4 63537.0 64872.4 65067.3 65325.0 15276.8 15320.8 15401.4 15407.8 15408.5 22774.5 22883.7 22977.8 22994.0 23020.7 8414.1 8417.6 8428.4 8455.1 8570.9 6988.9 6993.8 7066.2 7168.5 7172.0 7533.8 7623.5 7631.3 7641.6 7749.7 1700.2 1710.6 1716.0 1721.6 2123.9 826.3 855.6 913.7 928.0 962.1 13272.9 14651.6 15070.9 15331.2 16741.5 802.7 817.5 823.7 922.3 971.3 5582.2 5653.3 5793.1 5865.1 5875.7 489931.0 502775.0 505298.0 518233.0 546612.0 68537.7 69438.3 69499.3 70029.0 71259.3 466.0 469.4 469.4 469.5 470.0 9968.6 10143.5 13975.0 14496.3 14749.3 29571.9 29634.6 29719.9 30585.5 30622.5 36180.6 36890.0 38728.0 39003.8 39693.0 9223.1 9297.3 9428.7 9465.2 9469.7 11880.6 15403.5 15778.4 16353.6 17047.6 12630.2 12975.4 13372.2 13438.8 13572.7 13150.7 13279.1 13473.4 13558.9 13660.1 12751.9 12806.7 13271.9 13374.1 13881.6 8629.4 8838.9 8977.9 9008.1 9011.0 9570.3 9697.2 10597.6 13790.2 13803.7 16:50:19 INFO - 2015-11-20 16:50:19,917 DEBUG : BROWSER_OUTPUT: 16:50:19 INFO - 2015-11-20 16:50:19,917 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4764.21 Median:6052.43 stddev:2394.54 (39.6%) stddev-sans-first:2386.53 16:50:19 INFO - 2015-11-20 16:50:19,918 DEBUG : BROWSER_OUTPUT: Values: 1231.3 1270.9 1320.6 1425.1 1694.4 5719.2 6371.4 6654.4 6659.6 6667.2 6477.4 6585.7 6590.6 6598.7 6600.6 1767.1 1823.7 1825.2 2072.9 2101.7 1775.3 1784.8 2052.5 2097.8 2106.0 2085.0 2094.2 2094.2 2098.5 2098.9 2006.9 2062.9 2065.1 2065.4 2067.3 2093.2 2098.5 2127.4 2133.8 2136.9 6821.4 6879.1 6883.2 6890.6 6912.1 4077.7 4149.3 4156.7 4164.1 4169.1 2755.6 2786.8 2824.4 2834.3 2840.3 918.7 934.5 937.3 961.9 967.6 9035.1 9043.9 9051.0 9051.2 9060.9 3855.0 3948.9 3986.6 3988.3 3989.7 7790.5 7797.8 7817.1 7818.1 7825.3 4181.6 4197.4 4200.5 4206.5 4213.5 3791.1 3792.1 3812.2 3821.1 3822.7 3341.2 3382.5 3406.6 3433.1 3439.1 924.4 984.2 1124.7 1133.4 1137.5 907.3 913.3 913.7 917.7 1168.5 6341.2 6359.6 6379.6 6400.1 6404.1 1023.0 1032.3 1040.7 1049.9 1063.4 4970.7 5092.4 5093.1 5095.5 5102.1 7662.0 7960.3 8118.3 8125.7 8132.7 8001.3 8012.0 8016.5 8022.2 8028.2 6251.7 6315.9 6344.7 6405.9 6424.8 6182.6 6214.9 6226.6 6235.2 6235.5 7140.4 7241.9 7251.9 7263.7 7264.0 7377.5 7457.6 7489.4 7499.9 7573.8 6059.3 6117.8 6117.9 6118.9 6121.2 5484.6 6538.3 6575.2 6592.6 6609.9 5590.7 5761.6 5941.8 6045.7 6123.9 6048.1 6056.8 6076.1 6100.9 6136.0 6141.8 6157.1 6167.1 6175.9 6190.2 5611.3 5636.2 5649.6 5724.1 5725.6 5877.0 5906.7 5918.0 5919.3 5922.5 16:50:19 INFO - 2015-11-20 16:50:19,918 DEBUG : BROWSER_OUTPUT: 16:50:19 INFO - 2015-11-20 16:50:19,918 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4705.76 Median:5324.11 stddev:1376.12 (25.8%) stddev-sans-first:1339.91 16:50:19 INFO - 2015-11-20 16:50:19,919 DEBUG : BROWSER_OUTPUT: Values: 313.8 318.0 322.9 324.3 324.6 5180.3 5286.6 5343.4 5361.5 5420.9 5183.2 5295.6 5316.6 5331.6 5349.1 4007.0 4098.8 4218.1 4220.7 4228.0 4134.2 4213.7 4222.0 4227.9 4230.5 4183.8 4184.9 4184.9 4189.2 4194.4 4181.9 4183.0 4188.5 4189.1 4191.4 3709.7 3716.9 3719.9 3720.4 3721.6 4989.7 5098.4 5152.5 5173.2 5192.7 4788.1 4789.0 4792.8 4795.7 4800.0 5420.5 5548.4 5683.7 5694.5 5697.9 3885.6 3945.6 3969.5 3969.5 3971.6 5875.7 5903.1 5960.2 5967.5 5967.8 4062.8 4081.7 4087.0 4087.1 4087.9 4003.2 4120.0 4145.6 4146.3 4152.1 4691.2 4739.5 4742.9 4744.5 4745.5 5663.5 5667.6 5677.8 5678.5 5680.1 1448.3 1471.5 1471.5 1472.5 1472.6 990.9 993.6 993.8 994.1 1016.3 4955.0 4964.8 4967.7 4967.7 4976.2 5883.8 5884.8 5888.5 5888.8 5895.7 4956.2 4960.0 4963.2 4967.2 4969.2 3101.1 3144.3 3149.4 3165.3 3169.8 5541.3 5551.7 5552.1 5557.4 5560.0 6050.5 6052.5 6055.0 6064.9 6065.8 5560.6 5564.2 5570.5 5571.1 5574.6 5660.3 5698.7 5837.1 5893.4 5897.7 5613.9 5770.1 5773.5 5782.1 5782.9 5582.1 5591.7 5592.1 5598.6 5603.1 4058.9 4060.8 4068.1 4078.1 4081.5 5730.7 5877.8 5905.6 5917.1 5946.8 5678.8 5702.8 5710.5 5713.1 5721.9 5706.1 5706.3 5710.8 5711.2 5714.3 5438.9 5558.5 5576.7 5585.4 5589.9 5695.2 5736.3 5748.1 5749.9 5757.2 5618.0 5621.3 5621.6 5621.7 5631.2 16:50:19 INFO - 2015-11-20 16:50:19,920 DEBUG : BROWSER_OUTPUT: 16:50:19 INFO - 2015-11-20 16:50:19,920 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12148.90 Median:24677.58 stddev:13804.55 (55.9%) stddev-sans-first:13816.27 16:50:19 INFO - 2015-11-20 16:50:19,920 DEBUG : BROWSER_OUTPUT: Values: 650.3 713.0 740.4 745.5 766.4 10034.7 10204.9 10211.1 10223.4 10241.5 11060.7 11110.7 11133.4 11134.0 11152.2 616.7 624.1 781.4 783.0 796.7 789.6 790.8 799.9 800.7 801.4 824.4 837.7 839.3 839.3 839.5 650.2 658.3 811.5 824.8 827.7 606.4 611.8 612.6 612.7 613.0 11133.9 11178.6 11182.9 11230.4 11241.8 10465.2 11136.2 11207.7 11298.9 11353.8 8874.1 8925.3 9357.1 9605.8 9681.4 3151.0 3266.5 3267.2 3273.2 3296.6 39488.8 39502.8 39525.0 39578.4 39740.8 9266.5 9372.2 9411.8 9691.7 9783.5 16613.4 16637.2 16638.4 16660.8 16662.1 6243.5 6299.5 6314.8 6415.3 6684.9 3575.7 3618.6 3646.4 3662.5 3699.4 2715.8 2739.0 2740.7 2746.9 2749.1 491.9 493.8 506.1 506.3 507.7 491.9 550.5 581.1 592.8 615.8 7755.6 7833.8 7905.0 8032.3 8043.8 578.9 596.8 597.8 609.1 628.6 3706.8 3714.2 3749.9 3890.6 3893.1 48863.3 49563.5 49570.3 49641.0 49706.0 46575.5 46809.0 46879.0 47151.5 47239.8 40646.8 40969.8 40993.2 41763.8 42267.8 8034.0 8297.8 8311.8 8420.2 8578.0 29641.3 30263.7 30543.7 30654.2 30860.4 35227.0 35574.3 38550.4 39146.2 39250.4 9436.3 9532.0 9736.1 10014.3 10164.5 11210.9 11320.9 11710.4 11748.3 11795.9 9968.8 9984.9 10229.6 10230.4 10258.7 10083.3 10307.9 10355.4 10391.9 10680.6 10109.3 10240.3 10314.9 10421.8 10714.9 9227.3 9304.5 9338.6 9578.0 9713.9 9153.6 9193.0 9311.6 9320.8 9561.4 16:50:19 INFO - 2015-11-20 16:50:19,920 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:50:19 INFO - 2015-11-20 16:50:19,921 DEBUG : BROWSER_OUTPUT: 16:50:20 INFO - 2015-11-20 16:50:20,546 INFO : Browser exited with error code: 0 16:50:20 INFO - 2015-11-20 16:50:20,564 INFO : Completed test dromaeo_css (00:18:39) 16:50:20 INFO - 2015-11-20 16:50:20,564 INFO : Starting test kraken 16:50:20 INFO - 2015-11-20 16:50:20,564 DEBUG : operating with platform_type : linux_ 16:50:20 INFO - 2015-11-20 16:50:20,564 INFO : Initialising browser for kraken test... 16:50:20 INFO - 2015-11-20 16:50:20,570 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQuvz6G/profile http://localhost:48887/getInfo.html 16:50:24 INFO - 2015-11-20 16:50:24,617 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:50:24 INFO - 2015-11-20 16:50:24,617 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:50:24 INFO - 2015-11-20 16:50:24,617 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:50:24 INFO - 2015-11-20 16:50:24,617 DEBUG : BROWSER_OUTPUT: __metrics 16:50:24 INFO - 2015-11-20 16:50:24,787 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:50:26 INFO - 2015-11-20 16:50:26,140 INFO : Browser initialized. 16:50:26 INFO - 2015-11-20 16:50:26,141 INFO : Running cycle 1/1 for kraken test... 16:50:26 INFO - 2015-11-20 16:50:26,141 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQuvz6G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:50:38 INFO - 2015-11-20 16:50:38,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 139943936 16:50:38 INFO - 2015-11-20 16:50:38,004 DEBUG : BROWSER_OUTPUT: 16:50:40 INFO - 2015-11-20 16:50:40,612 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48887/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48887/tests/kraken/driver.html?testName=audio-beat-detection) 16:50:41 INFO - 2015-11-20 16:50:41,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 177635328 16:50:41 INFO - 2015-11-20 16:50:41,205 DEBUG : BROWSER_OUTPUT: 16:50:43 INFO - 2015-11-20 16:50:43,962 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48887/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48887/tests/kraken/driver.html?testName=audio-dft) 16:50:44 INFO - 2015-11-20 16:50:44,534 DEBUG : BROWSER_OUTPUT: RSS: Main: 168128512 16:50:44 INFO - 2015-11-20 16:50:44,534 DEBUG : BROWSER_OUTPUT: 16:50:47 INFO - 2015-11-20 16:50:47,541 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48887/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48887/tests/kraken/driver.html?testName=audio-fft) 16:50:48 INFO - 2015-11-20 16:50:48,108 DEBUG : BROWSER_OUTPUT: RSS: Main: 151838720 16:50:48 INFO - 2015-11-20 16:50:48,108 DEBUG : BROWSER_OUTPUT: 16:50:50 INFO - 2015-11-20 16:50:50,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48887/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48887/tests/kraken/driver.html?testName=audio-oscillator) 16:50:50 INFO - 2015-11-20 16:50:50,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 153985024 16:50:50 INFO - 2015-11-20 16:50:50,677 DEBUG : BROWSER_OUTPUT: 16:50:52 INFO - 2015-11-20 16:50:52,876 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48887/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48887/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:50:53 INFO - 2015-11-20 16:50:53,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 156278784 16:50:53 INFO - 2015-11-20 16:50:53,449 DEBUG : BROWSER_OUTPUT: 16:50:56 INFO - 2015-11-20 16:50:56,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48887/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48887/tests/kraken/driver.html?testName=imaging-darkroom) 16:50:57 INFO - 2015-11-20 16:50:57,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 155676672 16:50:57 INFO - 2015-11-20 16:50:57,037 DEBUG : BROWSER_OUTPUT: 16:51:00 INFO - 2015-11-20 16:51:00,458 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48887/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48887/tests/kraken/driver.html?testName=imaging-desaturate) 16:51:01 INFO - 2015-11-20 16:51:01,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 156516352 16:51:01 INFO - 2015-11-20 16:51:01,026 DEBUG : BROWSER_OUTPUT: 16:51:03 INFO - 2015-11-20 16:51:03,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48887/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48887/tests/kraken/driver.html?testName=json-parse-financial) 16:51:04 INFO - 2015-11-20 16:51:04,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 155013120 16:51:04 INFO - 2015-11-20 16:51:04,457 DEBUG : BROWSER_OUTPUT: 16:51:06 INFO - 2015-11-20 16:51:06,200 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48887/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48887/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:51:06 INFO - 2015-11-20 16:51:06,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 168939520 16:51:06 INFO - 2015-11-20 16:51:06,769 DEBUG : BROWSER_OUTPUT: 16:51:08 INFO - 2015-11-20 16:51:08,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48887/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48887/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:51:09 INFO - 2015-11-20 16:51:09,270 DEBUG : BROWSER_OUTPUT: RSS: Main: 168398848 16:51:09 INFO - 2015-11-20 16:51:09,271 DEBUG : BROWSER_OUTPUT: 16:51:11 INFO - 2015-11-20 16:51:11,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48887/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48887/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:51:11 INFO - 2015-11-20 16:51:11,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 177623040 16:51:11 INFO - 2015-11-20 16:51:11,973 DEBUG : BROWSER_OUTPUT: 16:51:14 INFO - 2015-11-20 16:51:14,481 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48887/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48887/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:51:15 INFO - 2015-11-20 16:51:15,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 182972416 16:51:15 INFO - 2015-11-20 16:51:15,067 DEBUG : BROWSER_OUTPUT: 16:51:17 INFO - 2015-11-20 16:51:17,687 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48887/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48887/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:51:18 INFO - 2015-11-20 16:51:18,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 183234560 16:51:18 INFO - 2015-11-20 16:51:18,260 DEBUG : BROWSER_OUTPUT: 16:51:20 INFO - 2015-11-20 16:51:20,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48887/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48887/tests/kraken/driver.html?testName=ai-astar) 16:51:20 INFO - 2015-11-20 16:51:20,275 DEBUG : BROWSER_OUTPUT: RSS: Main: 242491392 16:51:20 INFO - 2015-11-20 16:51:20,275 DEBUG : BROWSER_OUTPUT: 16:51:20 INFO - 2015-11-20 16:51:20,275 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:51:20 INFO - 2015-11-20 16:51:20,275 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:51:20 INFO - 2015-11-20 16:51:20,275 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:51:20 INFO - 2015-11-20 16:51:20,275 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:51:20 INFO - 2015-11-20 16:51:20,275 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;113;106;112;112;113;103;113;113;111 16:51:20 INFO - 2015-11-20 16:51:20,276 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;135;163;170;132;156;155;132;168;131 16:51:20 INFO - 2015-11-20 16:51:20,276 DEBUG : BROWSER_OUTPUT: |2;audio-dft;169;160;160;161;159;161;162;163;160;161 16:51:20 INFO - 2015-11-20 16:51:20,276 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;80;93;74;72;72;96;96;73 16:51:20 INFO - 2015-11-20 16:51:20,276 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;90;133;91;90;91;129;90;91;122 16:51:20 INFO - 2015-11-20 16:51:20,276 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;110;110;109;110;110;110 16:51:20 INFO - 2015-11-20 16:51:20,276 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;148;147;148;146;148;146;148;146;147 16:51:20 INFO - 2015-11-20 16:51:20,276 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;97;95;95;96;95;95;95 16:51:20 INFO - 2015-11-20 16:51:20,276 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;71;71;69;70;70;69;78;68;67 16:51:20 INFO - 2015-11-20 16:51:20,277 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;68;69;70;69;68;70;70 16:51:20 INFO - 2015-11-20 16:51:20,277 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;82;91;83;82;82;83;91;82;85 16:51:20 INFO - 2015-11-20 16:51:20,277 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;127;121;115;119;124;123;122;127;130 16:51:20 INFO - 2015-11-20 16:51:20,277 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;156;147;151;146;153;145;147;157;144;135 16:51:20 INFO - 2015-11-20 16:51:20,277 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;72;68;68;69;69;71;68;69 16:51:20 INFO - 2015-11-20 16:51:20,277 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:51:20 INFO - 2015-11-20 16:51:20,277 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:51:20 INFO - 2015-11-20 16:51:20,278 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,977 16:51:20 INFO - 2015-11-20 16:51:20,278 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:51:20 INFO - 2015-11-20 16:51:20,278 DEBUG : BROWSER_OUTPUT: __startTimestamp1448067080269__endTimestamp 16:51:20 INFO - 2015-11-20 16:51:20,278 DEBUG : BROWSER_OUTPUT: 16:51:20 INFO - 2015-11-20 16:51:20,279 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:51:20 INFO - 2015-11-20 16:51:20,279 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:51:20 INFO - 2015-11-20 16:51:20,279 DEBUG : BROWSER_OUTPUT: 16:51:20 INFO - 2015-11-20 16:51:20,279 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.90 Median:113.00 stddev:3.51 (3.1%) stddev-sans-first:3.64 16:51:20 INFO - 2015-11-20 16:51:20,279 DEBUG : BROWSER_OUTPUT: Values: 113.0 113.0 106.0 112.0 112.0 113.0 103.0 113.0 113.0 111.0 16:51:20 INFO - 2015-11-20 16:51:20,279 DEBUG : BROWSER_OUTPUT: 16:51:20 INFO - 2015-11-20 16:51:20,280 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.00 Median:157.00 stddev:15.82 (10.1%) stddev-sans-first:16.51 16:51:20 INFO - 2015-11-20 16:51:20,280 DEBUG : BROWSER_OUTPUT: Values: 158.0 135.0 163.0 170.0 132.0 156.0 155.0 132.0 168.0 131.0 16:51:20 INFO - 2015-11-20 16:51:20,280 DEBUG : BROWSER_OUTPUT: 16:51:20 INFO - 2015-11-20 16:51:20,280 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:161.00 stddev:2.84 (1.8%) stddev-sans-first:1.20 16:51:20 INFO - 2015-11-20 16:51:20,280 DEBUG : BROWSER_OUTPUT: Values: 169.0 160.0 160.0 161.0 159.0 161.0 162.0 163.0 160.0 161.0 16:51:20 INFO - 2015-11-20 16:51:20,281 DEBUG : BROWSER_OUTPUT: 16:51:20 INFO - 2015-11-20 16:51:20,281 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.30 Median:77.00 stddev:10.42 (13.5%) stddev-sans-first:10.72 16:51:20 INFO - 2015-11-20 16:51:20,282 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 80.0 93.0 74.0 72.0 72.0 96.0 96.0 73.0 16:51:20 INFO - 2015-11-20 16:51:20,282 DEBUG : BROWSER_OUTPUT: 16:51:20 INFO - 2015-11-20 16:51:20,282 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:101.80 Median:90.50 stddev:18.27 (20.2%) stddev-sans-first:18.96 16:51:20 INFO - 2015-11-20 16:51:20,282 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 133.0 91.0 90.0 91.0 129.0 90.0 91.0 122.0 16:51:20 INFO - 2015-11-20 16:51:20,282 DEBUG : BROWSER_OUTPUT: 16:51:20 INFO - 2015-11-20 16:51:20,282 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 16:51:20 INFO - 2015-11-20 16:51:20,282 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 16:51:20 INFO - 2015-11-20 16:51:20,282 DEBUG : BROWSER_OUTPUT: 16:51:20 INFO - 2015-11-20 16:51:20,283 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.50 stddev:0.94 (0.6%) stddev-sans-first:0.93 16:51:20 INFO - 2015-11-20 16:51:20,283 DEBUG : BROWSER_OUTPUT: Values: 146.0 148.0 147.0 148.0 146.0 148.0 146.0 148.0 146.0 147.0 16:51:20 INFO - 2015-11-20 16:51:20,283 DEBUG : BROWSER_OUTPUT: 16:51:20 INFO - 2015-11-20 16:51:20,283 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 16:51:20 INFO - 2015-11-20 16:51:20,283 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 97.0 95.0 95.0 96.0 95.0 95.0 95.0 16:51:20 INFO - 2015-11-20 16:51:20,283 DEBUG : BROWSER_OUTPUT: 16:51:20 INFO - 2015-11-20 16:51:20,283 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.20 Median:70.00 stddev:3.01 (4.3%) stddev-sans-first:3.16 16:51:20 INFO - 2015-11-20 16:51:20,283 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 71.0 69.0 70.0 70.0 69.0 78.0 68.0 67.0 16:51:20 INFO - 2015-11-20 16:51:20,283 DEBUG : BROWSER_OUTPUT: 16:51:20 INFO - 2015-11-20 16:51:20,283 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 16:51:20 INFO - 2015-11-20 16:51:20,283 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 68.0 69.0 70.0 69.0 68.0 70.0 70.0 16:51:20 INFO - 2015-11-20 16:51:20,283 DEBUG : BROWSER_OUTPUT: 16:51:20 INFO - 2015-11-20 16:51:20,283 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:83.00 stddev:3.84 (4.6%) stddev-sans-first:3.78 16:51:20 INFO - 2015-11-20 16:51:20,283 DEBUG : BROWSER_OUTPUT: Values: 80.0 82.0 91.0 83.0 82.0 82.0 83.0 91.0 82.0 85.0 16:51:20 INFO - 2015-11-20 16:51:20,283 DEBUG : BROWSER_OUTPUT: 16:51:20 INFO - 2015-11-20 16:51:20,283 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:123.50 stddev:4.36 (3.5%) stddev-sans-first:4.57 16:51:20 INFO - 2015-11-20 16:51:20,284 DEBUG : BROWSER_OUTPUT: Values: 121.0 127.0 121.0 115.0 119.0 124.0 123.0 122.0 127.0 130.0 16:51:20 INFO - 2015-11-20 16:51:20,284 DEBUG : BROWSER_OUTPUT: 16:51:20 INFO - 2015-11-20 16:51:20,284 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:149.00 stddev:6.49 (4.4%) stddev-sans-first:6.22 16:51:20 INFO - 2015-11-20 16:51:20,284 DEBUG : BROWSER_OUTPUT: Values: 156.0 147.0 151.0 146.0 153.0 145.0 147.0 157.0 144.0 135.0 16:51:20 INFO - 2015-11-20 16:51:20,284 DEBUG : BROWSER_OUTPUT: 16:51:20 INFO - 2015-11-20 16:51:20,284 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:1.35 (1.9%) stddev-sans-first:1.41 16:51:20 INFO - 2015-11-20 16:51:20,284 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 72.0 68.0 68.0 69.0 69.0 71.0 68.0 69.0 16:51:20 INFO - 2015-11-20 16:51:20,284 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:51:20 INFO - 2015-11-20 16:51:20,284 DEBUG : BROWSER_OUTPUT: 16:51:21 INFO - 2015-11-20 16:51:21,161 INFO : Browser exited with error code: 0 16:51:21 INFO - 2015-11-20 16:51:21,210 INFO : Completed test kraken (00:01:00) 16:51:21 INFO - 2015-11-20 16:51:21,210 INFO : Starting test v8_7 16:51:21 INFO - 2015-11-20 16:51:21,210 DEBUG : operating with platform_type : linux_ 16:51:21 INFO - 2015-11-20 16:51:21,210 INFO : Initialising browser for v8_7 test... 16:51:21 INFO - 2015-11-20 16:51:21,216 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMIb9e0/profile http://localhost:48887/getInfo.html 16:51:25 INFO - 2015-11-20 16:51:25,599 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:51:25 INFO - 2015-11-20 16:51:25,599 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:51:25 INFO - 2015-11-20 16:51:25,599 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:51:25 INFO - 2015-11-20 16:51:25,599 DEBUG : BROWSER_OUTPUT: __metrics 16:51:25 INFO - 2015-11-20 16:51:25,748 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:51:27 INFO - 2015-11-20 16:51:27,187 INFO : Browser initialized. 16:51:27 INFO - 2015-11-20 16:51:27,188 INFO : Running cycle 1/1 for v8_7 test... 16:51:27 INFO - 2015-11-20 16:51:27,188 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMIb9e0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:51:39 INFO - 2015-11-20 16:51:39,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 141418496 16:51:39 INFO - 2015-11-20 16:51:39,101 DEBUG : BROWSER_OUTPUT: 16:52:00 INFO - 2015-11-20 16:52:00,589 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48887/tests/v8_7/run.html (next: http://localhost:48887/tests/v8_7/run.html) 16:52:00 INFO - 2015-11-20 16:52:00,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 442343424 16:52:00 INFO - 2015-11-20 16:52:00,840 DEBUG : BROWSER_OUTPUT: 16:52:00 INFO - 2015-11-20 16:52:00,841 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:52:00 INFO - 2015-11-20 16:52:00,841 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:52:00 INFO - 2015-11-20 16:52:00,841 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:52:00 INFO - 2015-11-20 16:52:00,841 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:52:00 INFO - 2015-11-20 16:52:00,841 DEBUG : BROWSER_OUTPUT: |0;Richards;163.5858007524947 16:52:00 INFO - 2015-11-20 16:52:00,842 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.93857965451056 16:52:00 INFO - 2015-11-20 16:52:00,842 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.01785714285717 16:52:00 INFO - 2015-11-20 16:52:00,842 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5045.226130653266 16:52:00 INFO - 2015-11-20 16:52:00,842 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1984.126984126984 16:52:00 INFO - 2015-11-20 16:52:00,842 DEBUG : BROWSER_OUTPUT: |5;Earley;791.1392405063291 16:52:00 INFO - 2015-11-20 16:52:00,842 DEBUG : BROWSER_OUTPUT: |6;Boyer;11917.64705882353 16:52:00 INFO - 2015-11-20 16:52:00,842 DEBUG : BROWSER_OUTPUT: |7;RegExp;26710.526315789473 16:52:00 INFO - 2015-11-20 16:52:00,842 DEBUG : BROWSER_OUTPUT: |8;Splay;595.6316410861865 16:52:00 INFO - 2015-11-20 16:52:00,843 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 16:52:00 INFO - 2015-11-20 16:52:00,843 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:52:00 INFO - 2015-11-20 16:52:00,843 DEBUG : BROWSER_OUTPUT: __startTimestamp1448067120840__endTimestamp 16:52:00 INFO - 2015-11-20 16:52:00,843 DEBUG : BROWSER_OUTPUT: 16:52:00 INFO - 2015-11-20 16:52:00,843 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:52:00 INFO - 2015-11-20 16:52:00,844 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:52:00 INFO - 2015-11-20 16:52:00,844 DEBUG : BROWSER_OUTPUT: 16:52:00 INFO - 2015-11-20 16:52:00,845 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.59 Median:163.59 stddev:0.00 (0.0%) 16:52:00 INFO - 2015-11-20 16:52:00,845 DEBUG : BROWSER_OUTPUT: Values: 163.6 16:52:00 INFO - 2015-11-20 16:52:00,845 DEBUG : BROWSER_OUTPUT: 16:52:00 INFO - 2015-11-20 16:52:00,846 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.94 Median:191.94 stddev:0.00 (0.0%) 16:52:00 INFO - 2015-11-20 16:52:00,846 DEBUG : BROWSER_OUTPUT: Values: 191.9 16:52:00 INFO - 2015-11-20 16:52:00,846 DEBUG : BROWSER_OUTPUT: 16:52:00 INFO - 2015-11-20 16:52:00,846 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 16:52:00 INFO - 2015-11-20 16:52:00,846 DEBUG : BROWSER_OUTPUT: Values: 279.0 16:52:00 INFO - 2015-11-20 16:52:00,846 DEBUG : BROWSER_OUTPUT: 16:52:00 INFO - 2015-11-20 16:52:00,846 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5045.23 Median:5045.23 stddev:0.00 (0.0%) 16:52:00 INFO - 2015-11-20 16:52:00,846 DEBUG : BROWSER_OUTPUT: Values: 5045.2 16:52:00 INFO - 2015-11-20 16:52:00,847 DEBUG : BROWSER_OUTPUT: 16:52:00 INFO - 2015-11-20 16:52:00,847 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1984.13 Median:1984.13 stddev:0.00 (0.0%) 16:52:00 INFO - 2015-11-20 16:52:00,847 DEBUG : BROWSER_OUTPUT: Values: 1984.1 16:52:00 INFO - 2015-11-20 16:52:00,847 DEBUG : BROWSER_OUTPUT: 16:52:00 INFO - 2015-11-20 16:52:00,847 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.14 Median:791.14 stddev:0.00 (0.0%) 16:52:00 INFO - 2015-11-20 16:52:00,847 DEBUG : BROWSER_OUTPUT: Values: 791.1 16:52:00 INFO - 2015-11-20 16:52:00,847 DEBUG : BROWSER_OUTPUT: 16:52:00 INFO - 2015-11-20 16:52:00,848 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11917.65 Median:11917.65 stddev:0.00 (0.0%) 16:52:00 INFO - 2015-11-20 16:52:00,848 DEBUG : BROWSER_OUTPUT: Values: 11917.6 16:52:00 INFO - 2015-11-20 16:52:00,848 DEBUG : BROWSER_OUTPUT: 16:52:00 INFO - 2015-11-20 16:52:00,848 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26710.53 Median:26710.53 stddev:0.00 (0.0%) 16:52:00 INFO - 2015-11-20 16:52:00,848 DEBUG : BROWSER_OUTPUT: Values: 26710.5 16:52:00 INFO - 2015-11-20 16:52:00,848 DEBUG : BROWSER_OUTPUT: 16:52:00 INFO - 2015-11-20 16:52:00,848 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:595.63 Median:595.63 stddev:0.00 (0.0%) 16:52:00 INFO - 2015-11-20 16:52:00,848 DEBUG : BROWSER_OUTPUT: Values: 595.6 16:52:00 INFO - 2015-11-20 16:52:00,849 DEBUG : BROWSER_OUTPUT: 16:52:00 INFO - 2015-11-20 16:52:00,849 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 16:52:00 INFO - 2015-11-20 16:52:00,849 DEBUG : BROWSER_OUTPUT: Values: 4830.9 16:52:00 INFO - 2015-11-20 16:52:00,849 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:52:00 INFO - 2015-11-20 16:52:00,849 DEBUG : BROWSER_OUTPUT: 16:52:01 INFO - 2015-11-20 16:52:01,777 INFO : Browser exited with error code: 0 16:52:01 INFO - 2015-11-20 16:52:01,792 INFO : Completed test v8_7 (00:00:40) 16:52:02 INFO - 2015-11-20 16:52:02,281 INFO : Completed test suite (00:20:20) 16:52:02 INFO - 2015-11-20 16:52:02,282 DEBUG : Working with test: dromaeo_css 16:52:02 INFO - 2015-11-20 16:52:02,282 DEBUG : Generating results file: dromaeo_css 16:52:02 INFO - 2015-11-20 16:52:02,283 DEBUG : Working with test: kraken 16:52:02 INFO - 2015-11-20 16:52:02,283 DEBUG : Generating results file: kraken 16:52:02 INFO - 2015-11-20 16:52:02,283 INFO : javascript benchmark 16:52:02 INFO - 2015-11-20 16:52:02,283 DEBUG : Working with test: v8_7 16:52:02 INFO - 2015-11-20 16:52:02,284 DEBUG : Generating results file: v8_7 16:52:02 INFO - 2015-11-20 16:52:02,284 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:52:02 INFO - 2015-11-20 16:52:02,342 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 16:52:02 INFO - 2015-11-20 16:52:02,342 DEBUG : process_Request line: dromaeo_css 6322.55 graph.html#tests=[[72,132,35]] 16:52:02 INFO - 2015-11-20 16:52:02,343 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:52:02 INFO - 2015-11-20 16:52:02,374 DEBUG : process_Request line: kraken 1520.40 graph.html#tests=[[232,132,35]] 16:52:02 INFO - 2015-11-20 16:52:02,374 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:52:02 INFO - 2015-11-20 16:52:02,405 DEBUG : process_Request line: v8_7 19910.40 graph.html#tests=[[230,132,35]] 16:52:02 INFO - 2015-11-20 16:52:02,406 INFO : javascript benchmark 16:52:02 INFO - 2015-11-20 16:52:02,410 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2639.564471862143, 2732.494488519624, 2735.4802587508384, 2738.6165936768843, 2747.477979183955, 4493.752843593601, 4626.583607475327, 4633.235516139837, 4670.719756814589, 4689.507601701824, 4581.954180458194, 4632.444106707191, 4708.929366059503, 4709.929351059737, 4721.598664113554, 4320.546342634026, 4384.364267181257, 4401.977990110045, 4406.0, 4421.09367579647, 4184.644305234059, 4390.517043125254, 4411.823527058914, 4440.400545926307, 4449.4660640723, 4152.397902304149, 4223.788810559459, 4262.680298977589, 4288.506821715511, 4304.225239456897, 4332.761698106603, 4333.479982402132, 4334.566543345672, 4342.066455712037, 4386.758728269944, 4166.375043743433, 4256.425382573375, 4303.784810759481, 4313.805878735465, 4344.326629372421, 4543.977280113579, 4565.794539245742, 4641.3270075839155, 4663.393758811367, 4686.742229177394, 5095.261187127846, 5098.97450512745, 5122.564582010496, 5140.254663073871, 5163.741812909339, 4838.516148385169, 4952.059108769322, 5125.256837758504, 5138.974305128488, 5147.176451767737, 4567.611753001032, 4614.907701845944, 4645.187092258909, 4648.86053418398, 4700.835470758507, 5183.196604526304, 5212.270282160424, 5232.372115346183, 5235.921461178085, 5267.841964741064, 4727.905441891143, 4836.250381190921, 4993.875153121201, 5005.374328208974, 5008.323876276656, 4875.122477953932, 4928.507149285115, 4969.701817890938, 4972.801087956514, 4990.950090499121, 5006.3992320921, 5009.0, 5010.048090862724, 5018.146915024455, 5049.091163590589, 4734.337192793012, 4844.636652251095, 4975.353204083446, 4978.90042199154, 5025.3718285214345, 4071.8371265149653, 4124.340105583093, 4140.213359461693, 4155.97922010388, 4160.854370097032, 3720.6465385788306, 3724.0131365188245, 3729.21686445844, 3730.403135498307, 3761.492198553215, 4168.937465938014, 4373.0, 4379.211741886491, 4385.693001489929, 4429.889252768707, 4943.307936888838, 4968.950310496849, 5008.474110218447, 5123.666961647481, 5139.794408223704, 4347.652187824967, 4348.67384946124, 4364.083542456056, 4364.869053928387, 4403.075354175595, 4493.236149854532, 4498.775061246924, 4504.729716217037, 4506.842260520866, 4548.249538826123, 4564.977175114103, 4676.345311656439, 4686.812527498998, 4754.286856971482, 4859.392575927938, 5154.561862241601, 5157.458466860926, 5158.767855446589, 5162.819301324435, 5183.300254465599, 4869.074875773592, 4869.878253043702, 4877.512248775094, 4883.682560633548, 4913.164761990399, 4709.4584122824945, 4816.95183048165, 4824.782884770124, 4888.706677599355, 5075.593952483866, 5079.415867175322, 5082.3138876252715, 5082.847514574569, 5084.135696931605, 5091.0, 4898.4121905371585, 4902.068606964808, 4902.681325713817, 4905.3623029006, 4946.183879659816, 4619.538046195354, 4754.500777418321, 4758.7858546364805, 4833.275008748576, 4950.603951683928, 4804.855854324376, 4822.445418776885, 4826.686265392738, 4862.781174847211, 4874.561289483963, 4934.679245849008, 4937.0, 4940.530649588283, 4941.2835138905375, 4981.37732783402, 4551.681382303207, 4655.976720116378, 4666.719996800203, 4827.444843843003, 4833.685810422311], "unit": "ms", "name": "dojo.html", "value": 4609.56578290705}, {"lowerIsBetter": false, "replicates": [559.4992481728852, 566.0914232656588, 570.4438172781537, 572.2703552969964, 574.9568782341325, 28334.149975500743, 28824.0, 28913.421731565355, 28917.421651566983, 36709.0, 40314.59685403145, 40884.38673419894, 40944.79527602365, 41034.58965410345, 41046.58953410465, 7846.607669616525, 8018.67925282988, 8022.277994980451, 8023.39824513161, 8028.0767711713315, 7084.787456376317, 7267.563946163247, 7269.527480713763, 7269.672864721074, 7892.881606775903, 7044.506884518086, 7108.537945033582, 9851.753706157368, 10058.647947321846, 10065.0, 9722.854157187649, 9818.410895346302, 9820.90179098207, 9836.754081147958, 9863.457509836957, 7043.436525077981, 9691.0617876425, 9822.557984890696, 9832.705018849447, 9832.901670983341, 28248.576271355945, 41731.582684173074, 42796.0, 42802.35796463056, 42812.57187428117, 2864.5130327844317, 2892.7251911068415, 2914.9125526234034, 2928.546075358323, 3628.11111277736, 28083.157505274874, 28282.717172828216, 28284.71715282862, 28298.858505707547, 28909.0, 3315.370079684852, 3383.226372224672, 3418.6410426905313, 3504.632013638582, 3549.0240183949363, 203769.0, 203903.0, 204853.0, 205164.97417512967, 205451.0, 53475.19787203195, 53660.0, 53775.19337209945, 53788.46211537913, 53843.73078134584, 56297.71851140718, 56469.0, 56542.43457565454, 56705.14942275869, 56765.43234567602, 13199.538016169388, 13427.865721342858, 13567.932160339134, 13573.0, 13600.115992460458, 9114.0, 9137.77155571116, 9146.2682985361, 9146.679866204784, 9150.222231110298, 18803.623927521374, 18850.434486965412, 19146.0, 19208.903955480135, 19214.0, 7542.660580273791, 7903.802404939807, 7935.960320198362, 7966.681332746741, 7966.888774474769, 765.559803113201, 808.2887059387701, 954.5418199264253, 969.3505351414569, 972.601233494264, 25322.493550128893, 25503.744962550136, 25529.489410212063, 25629.48741025169, 25644.0, 893.8972018217988, 903.3495882964387, 906.2795077913075, 929.2194556572512, 942.5098948546718, 12079.879201208052, 12293.815592766116, 12337.0, 12827.422765975554, 15099.924500377429, 272132.0, 281435.0, 281740.0, 282421.0, 282601.0, 49241.26138107931, 49443.50556494389, 49551.256731149064, 49621.25568116481, 49626.50373496291, 1143.3768596115137, 1166.2827361172817, 1181.5982565927454, 1199.580146948561, 1199.9700007499707, 27449.0, 27975.860120699268, 28371.038704013976, 28492.715072849005, 28686.282842929093, 41601.1679766409, 41914.0, 42055.0, 42110.0, 42116.0, 265527.0, 268851.0, 269348.0, 269386.0, 269498.0, 24699.876500618102, 25039.624405633567, 25129.623055654545, 25214.0, 25358.239252822445, 34796.82601586976, 35177.29645407027, 35757.46363804493, 35806.283874321845, 35968.28063438664, 30436.695633044274, 32458.0, 33134.0, 33774.32451351008, 33920.83039584885, 33433.83283083666, 33882.152946176546, 33884.49173262354, 34109.0, 34379.0, 32989.83505082459, 33351.332973339915, 33666.49500257449, 33739.662603373654, 33838.0, 28455.146345609664, 29175.562366564092, 29786.553201701558, 29865.104046878627, 30029.69970300269, 23057.769422305562, 23660.17189398363, 23830.88084559566, 23982.28053158408, 24006.27981160568], "unit": "ms", "name": "ext.html", "value": 16857.037317620765}, {"lowerIsBetter": false, "replicates": [327.6674175711653, 331.19498731911085, 333.3433136720661, 335.0467918771095, 337.22438391699086, 12491.687707807308, 12929.870701292984, 14924.925375373121, 15337.156456394894, 15888.205589720512, 9779.217662586994, 10019.499025048737, 10037.046480584351, 15081.170535620537, 15280.159591222478, 4567.520410356915, 4684.906301873961, 4694.906101877978, 4697.67116301859, 4707.505711900252, 3902.083010492532, 3999.960000399988, 6220.751169953196, 6529.902051469232, 6821.249662537117, 6627.900581491257, 6704.564203326792, 6749.93250067498, 6775.9661201693925, 6789.626570538619, 6713.328667133296, 6748.797536073926, 6790.0, 6790.253072162058, 6795.762148324785, 6376.521760867907, 6493.707783149723, 6496.707648155844, 6586.571872828251, 6597.1423714916755, 15512.534623961299, 15560.688786224326, 15570.221488925508, 20494.872781996983, 20605.896970515052, 1884.4629280654947, 1924.3457224543583, 1944.6596845552112, 1955.4036019014195, 2014.7783743788173, 13757.518486853012, 13785.172889626654, 13797.10318829273, 14141.505047323295, 14462.638434039232, 1813.4922221777924, 1835.2658936425403, 1843.4285371534868, 1897.2411035585737, 1960.7451031365974, 61434.38565614376, 63537.0, 64872.351276487105, 65067.3493265066, 65325.0, 15276.770848437282, 15320.770188447183, 15401.383944642088, 15407.768883466757, 15408.460703875535, 22774.544509110056, 22883.656745148837, 22977.7702222979, 22994.0, 23020.654690179326, 8414.074451810297, 8417.60098371961, 8428.410011299273, 8455.112213217524, 8570.914290857012, 6988.895166572505, 6993.755218567326, 7066.187388450291, 7168.53404528704, 7171.964140179266, 7533.773986780406, 7623.504472209289, 7631.313181813553, 7641.579713115832, 7749.728759493503, 1700.200905574378, 1710.63221407398, 1715.9914200428918, 1721.5954250751063, 2123.9168024307714, 826.3182874128868, 855.6021450025768, 913.6847787513298, 927.9814403712023, 962.0908241711655, 13272.933635331954, 14651.633709157357, 15070.924645376923, 15331.156786376856, 16741.49775506737, 802.7431222009018, 817.5054092274207, 823.6869989403988, 922.2714055895767, 971.3297824501071, 5582.190582365615, 5653.265075540236, 5793.102069179284, 5865.061590145556, 5875.706214689249, 489931.0, 502775.0, 505298.0, 518233.0, 546612.0, 68537.65731171412, 69438.30561694318, 69499.30500694929, 70029.0, 71259.2874071263, 466.02368038958326, 469.3546373736113, 469.3780740518758, 469.4765336649611, 469.98825029373853, 9968.55141518619, 10143.49282535885, 13975.0, 14496.34766435534, 14749.262536873328, 29571.85214073916, 29634.55548166736, 29719.851400742857, 30585.54121688132, 30622.540661890536, 36180.63819361878, 36890.0, 38728.0, 39003.80498097491, 39693.0, 9223.123803238681, 9297.30270229722, 9428.717138485856, 9465.195458386115, 9469.715908522756, 11880.643580692593, 15403.460878869186, 15778.36886524572, 16353.591160221089, 17047.573810654834, 12630.242185468902, 12975.351232438152, 13372.197668139943, 13438.798418023542, 13572.72854542884, 13150.671233219246, 13279.136856104322, 13473.393697283842, 13558.864411356155, 13660.112092713942, 12751.872481275439, 12806.67983300425, 13271.933640331736, 13374.13068150567, 13881.583552493441, 8629.39594228398, 8838.867416988878, 8977.910220897707, 9008.099190080939, 9011.0, 9570.282228832726, 9697.224222062077, 10597.62908298206, 13790.241536715577, 13803.654908627364], "unit": "ms", "name": "jquery.html", "value": 8582.348111836407}, {"lowerIsBetter": false, "replicates": [1231.2981600487724, 1270.872912708729, 1320.6038188543434, 1425.1449130521682, 1694.3815507339825, 5719.170720245567, 6371.362863713632, 6654.367835055674, 6659.600423974565, 6667.166604174478, 6477.417032467077, 6585.736570537185, 6590.571612845161, 6598.736050557984, 6600.570962887409, 1767.1252729898717, 1823.717323814811, 1825.196913358125, 2072.8963551822385, 2101.737282839645, 1775.3076300242915, 1784.8215178482178, 2052.548439343342, 2097.7797331280226, 2106.010175217653, 2085.030460835711, 2094.1937354118622, 2094.214669498938, 2098.527831237967, 2098.8740675559516, 2006.9162652167886, 2062.896855157251, 2065.0500769646055, 2065.4320061982926, 2067.3281183615386, 2093.2464312847364, 2098.548812005411, 2127.393692797545, 2133.7866213378693, 2136.8504204705678, 6821.386075253202, 6879.140107486564, 6883.208431030395, 6890.552114112566, 6912.101426814532, 4077.6941729370415, 4149.33610622299, 4156.709030367875, 4164.12553363794, 4169.10364271683, 2755.5728862026417, 2786.8188567743236, 2824.3503994081475, 2834.2630915962, 2840.2899275181203, 918.7473444802666, 934.509382574154, 937.3110763588757, 961.8845738511353, 967.6322997260996, 9035.141661542142, 9043.864342034874, 9051.0, 9051.185393314567, 9060.909390906072, 3854.9614503854605, 3948.940765888514, 3986.5814089520763, 3988.3219852624543, 3989.740666856645, 7790.454668173287, 7797.80505487356, 7817.140114587391, 7818.14000459949, 7825.334846538108, 4181.60274773896, 4197.433346498245, 4200.453940987713, 4206.49522057349, 4213.5154457237195, 3791.1469919268498, 3792.1467669774634, 3812.218495208476, 3821.121142137324, 3822.6750726188584, 3341.231516751161, 3382.5433566468705, 3406.5571475707998, 3433.124553238958, 3439.1402149462633, 924.4314746430897, 984.2077127912099, 1124.6794663520857, 1133.4106264742288, 1137.533611219396, 907.3240435875315, 913.2693844924034, 913.7167478081816, 917.6788124156492, 1168.462507246659, 6341.23905131378, 6359.618422894641, 6379.585326953733, 6400.135981642512, 6404.071409645575, 1022.9539670714836, 1032.3341444768082, 1040.6773900090996, 1049.8635177427038, 1063.3832377221192, 4970.65205435616, 5092.414372347227, 5093.0577843099145, 5095.541401273903, 5102.132637451642, 7661.965634639364, 7960.283574478209, 8118.269355757892, 8125.715599954092, 8132.6746930122135, 8001.319887809485, 8011.95695097758, 8016.519008859487, 8022.197780221931, 8028.197180282042, 6251.718397728455, 6315.894718424257, 6344.6827658616885, 6405.871882562323, 6424.807255782241, 6182.598131121463, 6214.875702486015, 6226.62640241587, 6235.158253635701, 6235.532335074979, 7140.428765698835, 7241.855162896607, 7251.927480725125, 7263.673134709056, 7263.963680181565, 7377.5204611700065, 7457.6271186441545, 7489.400847932044, 7499.88750168737, 7573.810654733676, 6059.303180134341, 6117.84705382369, 6117.908231376622, 6118.877622447437, 6121.204243448501, 5484.61607687458, 6538.313477084837, 6575.243846957661, 6592.571482853599, 6609.900851487328, 5590.664560126405, 5761.625494342854, 5941.792037278675, 6045.667488288186, 6123.908141377794, 6048.092786082123, 6056.757729690763, 6076.1493390924425, 6100.938990610037, 6136.0, 6141.754329826936, 6157.138000679998, 6167.074938759222, 6175.876482470236, 6190.226221722285, 5611.270534830446, 5636.239107720406, 5649.604527683023, 5724.141378793214, 5725.627834190765, 5876.970615146897, 5906.734196961061, 5918.0, 5919.289685237627, 5922.496587789914], "unit": "ms", "name": "mootools.html", "value": 3954.7659146373994}, {"lowerIsBetter": false, "replicates": [313.7725149266781, 318.0282250049691, 322.9289556297614, 324.25583286357806, 324.56022090067955, 5180.274761533379, 5286.629935904488, 5343.438938911417, 5361.490658387452, 5420.91868621971, 5183.17069268917, 5295.602829787762, 5316.627836051468, 5331.600129990247, 5349.144136938091, 4006.959930400688, 4098.7540747555095, 4218.11419601884, 4220.662347012247, 4228.0, 4134.214499245134, 4213.662906967435, 4221.978890105561, 4227.915441691164, 4230.534641189467, 4183.811728472211, 4184.8535301264465, 4184.937225941613, 4189.245935731567, 4194.412782210493, 4181.937270940938, 4182.979085104555, 4188.539260681323, 4189.120284740208, 4191.434156388909, 3709.684676802475, 3716.9442458363146, 3719.9442008369897, 3720.3675375186285, 3721.5534135903863, 4989.725565093919, 5098.388193416777, 5152.510511501401, 5173.1722924331925, 5192.688438693691, 4788.11419887322, 4788.95211047892, 4792.832250871203, 4795.736234507101, 4800.039992001579, 5420.512153906128, 5548.361938377098, 5683.74423150955, 5694.5159661428415, 5697.886042279172, 3885.630865067814, 3945.5659877413464, 3969.4641223434755, 3969.4839670842894, 3971.6226958439192, 5875.676837773921, 5903.085021821582, 5960.195373624549, 5967.49276311514, 5967.791127310524, 4062.8171732272117, 4081.714280000431, 4087.0, 4087.1008378156757, 4087.89780255496, 4003.2393845169327, 4119.958800412018, 4145.626893579592, 4146.315857883415, 4152.1280531088805, 4691.249400095969, 4739.526047395233, 4742.905141897143, 4744.5492678195515, 4745.525447455227, 5663.546916246691, 5667.574931880125, 5677.77288908439, 5678.545716342683, 5680.11958146488, 1448.3192899337294, 1471.5070451398901, 1471.5364660132025, 1472.536151112396, 1472.639203395175, 990.9454979976026, 993.5677980078544, 993.7863359377624, 994.110271307176, 1016.3343010328247, 4954.950450495449, 4964.826231081895, 4967.652264341534, 4967.7019378837385, 4976.2286845539, 5883.823485295448, 5884.823455296348, 5888.5289176865745, 5888.823335299948, 5895.734691938873, 4956.207006878882, 4960.0, 4963.230699241623, 4967.230079337708, 4969.155243608595, 3101.0916041553614, 3144.2925341797913, 3149.3858697554215, 3165.3036332006923, 3169.7939633924184, 5541.251930989345, 5551.694656793915, 5552.111662134039, 5557.41647127054, 5560.0, 6050.455459008623, 6052.455279024821, 6054.969725151434, 6064.878702425926, 6065.8180254592435, 5560.555155587544, 5564.1931919871395, 5570.498655120978, 5571.1086226203615, 5574.609777315712, 5660.320761508646, 5698.6635479453225, 5837.09525023622, 5893.410658934073, 5897.705114744332, 5613.915791263053, 5770.076787713946, 5773.480386765212, 5782.074868021096, 5782.855428614318, 5582.106862902078, 5591.748371323219, 5592.133219351007, 5598.636088654224, 5603.10350343943, 4058.898527536835, 4060.837566497307, 4068.0846809467635, 4078.1028173801715, 4081.5306239781617, 5730.74211660468, 5877.823665290048, 5905.645661260338, 5917.142014407801, 5946.791862284799, 5678.801241956512, 5702.800401985911, 5710.543156547549, 5713.143028545752, 5721.942780572307, 5706.087026075808, 5706.343770466284, 5710.771569137188, 5711.171880077282, 5714.257146571085, 5438.864028399322, 5558.499735023867, 5576.749046293007, 5585.413531579288, 5589.888202236014, 5695.231143795535, 5736.282964629421, 5748.051571490657, 5749.856253593526, 5757.165211044459, 5617.9719101404235, 5621.325440946949, 5621.578381621313, 5621.7189140542, 5631.155326700864], "unit": "ms", "name": "prototype.html", "value": 4268.108536568392}, {"lowerIsBetter": false, "replicates": [650.3236633900742, 713.0373995106606, 740.4076738609111, 745.5228653661654, 766.4098644044083, 10034.698959031222, 10204.948975255124, 10211.081002709754, 10223.437710925897, 10241.487925603727, 11060.668179954615, 11110.722231944206, 11133.443327833596, 11134.0, 11152.219344645859, 616.6824085595922, 624.0514418084509, 781.4412694923129, 782.9608519574027, 796.7052190689424, 789.5973053742575, 790.8181118342785, 799.8960135182418, 800.747764454198, 801.4149670740363, 824.4476200945351, 837.6816809612338, 839.3243439031577, 839.3243439031577, 839.5130824122025, 650.229478068488, 658.2758965138333, 811.4968719393954, 824.8185399212164, 827.664795757719, 606.4208680709911, 611.7828170999276, 612.6385432594791, 612.702839123025, 612.9846753831146, 11133.944330278378, 11178.552857885676, 11182.944085279603, 11230.438478076063, 11241.83137252942, 10465.162786977024, 11136.164787640959, 11207.66377008691, 11298.943505282503, 11353.772924541545, 8874.112588741138, 8925.330600204945, 9357.111074447917, 9605.759856003586, 9681.419114853132, 3150.952735708966, 3266.526353678727, 3267.18320419895, 3273.165342837585, 3296.604407471119, 39488.80255598732, 39502.802485987675, 39525.0, 39578.40632390545, 39740.801295993624, 9266.490343031062, 9372.1565059145, 9411.811763764686, 9691.70924872255, 9783.510824458748, 16613.41853035138, 16637.168141592872, 16638.417655382247, 16660.833391666172, 16662.08358540292, 6243.469305109116, 6299.496040316855, 6314.810555683245, 6415.326390728999, 6684.899726504106, 3575.7318201135017, 3618.620044895301, 3646.3801153803915, 3662.505561749183, 3699.389600715852, 2715.7963152763623, 2739.000264903296, 2740.671119465677, 2746.931326716848, 2749.1065403743864, 491.8967016926414, 493.83456542058093, 506.0839879817542, 506.25074889164244, 507.710604955172, 491.9237518184687, 550.5017958747341, 581.1050981488545, 592.762894842058, 615.7906311853991, 7755.573443460551, 7833.843323133506, 7904.960475197702, 8032.277095061356, 8043.826697961916, 578.9363170051291, 596.7911231069178, 597.8146774499832, 609.071166471135, 628.5945565110478, 3706.777593344408, 3714.1643130295465, 3749.9437508437395, 3890.6109389061435, 3893.0656642406184, 48863.26705099426, 49563.50436495661, 49570.25644615333, 49641.0, 49706.0, 46575.53424465712, 46809.0, 46879.0, 47151.5284847154, 47239.76380118077, 40646.79676601598, 40969.79515102465, 40993.1801363977, 41763.7911810439, 42267.788661057115, 8033.959830200812, 8297.834043318979, 8311.750647480585, 8420.242178203991, 8578.0, 29641.25896852596, 30263.697363026968, 30543.694563054087, 30654.233644158183, 30860.382792344477, 35227.0, 35574.288514229054, 38550.42174367331, 39146.2170756589, 39250.41124383079, 9436.292278079034, 9531.952340238255, 9736.075072868067, 10014.3490673106, 10164.491775411348, 11210.887891120985, 11320.886791131983, 11710.355930423568, 11748.29510229389, 11795.882041179822, 9968.847352024923, 9984.850227246452, 10229.590816367261, 10230.437325947145, 10258.692239232834, 10083.344582602107, 10307.896921030693, 10355.378677279386, 10391.948040259751, 10680.57277708883, 10109.34289271195, 10240.334378265388, 10314.935581358526, 10421.843672345072, 10714.946425267824, 9227.30795190377, 9304.534773261175, 9338.626454941726, 9578.0, 9713.902860971582, 9153.588088536166, 9193.0, 9311.603259511128, 9320.766980825534, 9561.426314420878], "unit": "ms", "name": "yui.html", "value": 5674.160006162052}], "name": "dromaeo_css", "value": 6322.545413249095}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 113.0, 106.0, 112.0, 112.0, 113.0, 103.0, 113.0, 113.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [158.0, 135.0, 163.0, 170.0, 132.0, 156.0, 155.0, 132.0, 168.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.0}, {"lowerIsBetter": true, "replicates": [169.0, 160.0, 160.0, 161.0, 159.0, 161.0, 162.0, 163.0, 160.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 80.0, 93.0, 74.0, 72.0, 72.0, 96.0, 96.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [91.0, 90.0, 133.0, 91.0, 90.0, 91.0, 129.0, 90.0, 91.0, 122.0], "unit": "ms", "name": "audio-oscillator", "value": 101.8}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 147.0, 148.0, 146.0, 148.0, 146.0, 148.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 97.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 71.0, 69.0, 70.0, 70.0, 69.0, 78.0, 68.0, 67.0], "unit": "ms", "name": "json-parse-financial", "value": 70.2}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 68.0, 69.0, 70.0, 69.0, 68.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 91.0, 83.0, 82.0, 82.0, 83.0, 91.0, 82.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.1}, {"lowerIsBetter": true, "replicates": [121.0, 127.0, 121.0, 115.0, 119.0, 124.0, 123.0, 122.0, 127.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.9}, {"lowerIsBetter": true, "replicates": [156.0, 147.0, 151.0, 146.0, 153.0, 145.0, 147.0, 157.0, 144.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 72.0, 68.0, 68.0, 69.0, 69.0, 71.0, 68.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1520.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.5858007524947], "unit": "score", "name": "Richards", "value": 215.80112600000007}, {"lowerIsBetter": false, "replicates": [191.93857965451056], "unit": "score", "name": "DeltaBlue", "value": 344.4747799999999}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5045.226130653266], "unit": "score", "name": "Decrypt", "value": 52.75898306772911}, {"lowerIsBetter": false, "replicates": [1984.126984126984], "unit": "score", "name": "RayTrace", "value": 372.9544560000001}, {"lowerIsBetter": false, "replicates": [791.1392405063291], "unit": "score", "name": "Earley", "value": 842.4092320000002}, {"lowerIsBetter": false, "replicates": [11917.64705882353], "unit": "score", "name": "Boyer", "value": 55.922364264560706}, {"lowerIsBetter": false, "replicates": [26710.526315789473], "unit": "score", "name": "RegExp", "value": 34.105842364532016}, {"lowerIsBetter": false, "replicates": [595.6316410861865], "unit": "score", "name": "Splay", "value": 136.81442418235883}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19910.404934071274}]} 16:52:02 INFO - RETURN: dromaeo_css: 6322.55 16:52:02 INFO - RETURN: kraken: 1520.40 16:52:02 INFO - RETURN: v8_7: 19910.40 16:52:02 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19910.40"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1520.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6322.55"}}} 16:52:02 INFO - Return code: 0 16:52:02 INFO - # TBPL SUCCESS # 16:52:02 INFO - Running post-action listener: _resource_record_post_action 16:52:02 INFO - Running post-run listener: _resource_record_post_run 16:52:03 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 24576; Write bytes: 503402496; Read time: 40; Write time: 422016 16:52:03 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 121421824; Read time: 0; Write time: 101432 16:52:03 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 20480; Write bytes: 355934208; Read time: 32; Write time: 312156 16:52:03 INFO - Running post-run listener: _upload_blobber_files 16:52:03 INFO - Blob upload gear active. 16:52:03 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:52:03 INFO - Copying logs to upload dir... 16:52:03 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1263.787076 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-20 16:52:03.490979) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:52:03.494194) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009978 build_url: 'https://queue.taskcluster.net/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:52:03.545491) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:52:03.545837) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1448065857.590682-205193807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:52:03.598360) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 16:52:03.599092) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 16:52:03.599752) ========= ========= Total master_lag: 0.21 =========