builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1448065775.95 results: success (0) buildid: 20151120144638 builduid: b10eb016d3974000aaa3c480f91b874d revision: 809ef65b4a96cfb02ef3acfdb664fa03394a0195 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 16:29:35.948583) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 16:29:35.949016) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 16:29:35.949303) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006467 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 16:29:35.967203) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 16:29:35.967476) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 16:29:35.974936) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:29:35.975200) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004198 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:29:36.022568) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:29:36.022873) ========= 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:29:36.023224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:29:36.023503) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 16:29:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.8M=0s 2015-11-20 16:29:36 (43.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179197 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:29:36.215155) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:29:36.215522) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022066 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:29:36.264512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:29:36.264906) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 16:29:36,570 truncating revision to first 12 chars 2015-11-20 16:29:36,570 Setting DEBUG logging. 2015-11-20 16:29:36,570 attempt 1/10 2015-11-20 16:29:36,570 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:29:36,829 unpacking tar archive at: fx-team-809ef65b4a96/testing/mozharness/ program finished with exit code 0 elapsedTime=0.529526 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:29:36.807598) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 16:29:36.807977) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 16:29:36.814726) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 16:29:36.814991) ========= 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:29:36.815380) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-20 16:29:36.815681) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:29:37 INFO - MultiFileLogger online at 20151120 16:29:37 in /builds/slave/test 16:29:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:29:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:29:37 INFO - {'append_to_log': False, 16:29:37 INFO - 'base_work_dir': '/builds/slave/test', 16:29:37 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:29:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:29:37 INFO - 'branch': 'Fx-Team-Non-PGO', 16:29:37 INFO - 'buildbot_json_path': 'buildprops.json', 16:29:37 INFO - 'config_files': ('talos/linux_config.py',), 16:29:37 INFO - 'default_actions': ('clobber', 16:29:37 INFO - 'read-buildbot-config', 16:29:37 INFO - 'download-and-extract', 16:29:37 INFO - 'populate-webroot', 16:29:37 INFO - 'create-virtualenv', 16:29:37 INFO - 'install', 16:29:37 INFO - 'run-tests'), 16:29:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:29:37 INFO - 'download_minidump_stackwalk': True, 16:29:37 INFO - 'download_symbols': 'ondemand', 16:29:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:29:37 INFO - 'tooltool.py': '/tools/tooltool.py', 16:29:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:29:37 INFO - '/tools/misc-python/virtualenv.py')}, 16:29:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:29:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:29:37 INFO - 'installer_path': 'installer.exe', 16:29:37 INFO - 'log_level': 'info', 16:29:37 INFO - 'log_name': 'talos', 16:29:37 INFO - 'log_to_console': True, 16:29:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:29:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:29:37 INFO - 'opt_config_files': (), 16:29:37 INFO - 'pip_index': False, 16:29:37 INFO - 'sps_profile': False, 16:29:37 INFO - 'sps_profile_interval': 0, 16:29:37 INFO - 'suite': 'dromaeojs-e10s', 16:29:37 INFO - 'system_bits': '64', 16:29:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:29:37 INFO - 'title': 'talos-linux64-ix-015', 16:29:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:29:37 INFO - 'use_talos_json': True, 16:29:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:29:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:29:37 INFO - 'work_dir': 'build'} 16:29:37 INFO - ##### 16:29:37 INFO - ##### Running clobber step. 16:29:37 INFO - ##### 16:29:37 INFO - Running pre-action listener: _resource_record_pre_action 16:29:37 INFO - Running main action method: clobber 16:29:37 INFO - rmtree: /builds/slave/test/build 16:29:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:29:37 INFO - Running post-action listener: _resource_record_post_action 16:29:37 INFO - ##### 16:29:37 INFO - ##### Running read-buildbot-config step. 16:29:37 INFO - ##### 16:29:37 INFO - Running pre-action listener: _resource_record_pre_action 16:29:37 INFO - Running main action method: read_buildbot_config 16:29:37 INFO - Using buildbot properties: 16:29:37 INFO - { 16:29:37 INFO - "properties": { 16:29:37 INFO - "buildnumber": 492, 16:29:37 INFO - "product": "firefox", 16:29:37 INFO - "script_repo_revision": "production", 16:29:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:29:37 INFO - "repository": "", 16:29:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 16:29:37 INFO - "buildid": "20151120144638", 16:29:37 INFO - "slavename": "talos-linux64-ix-015", 16:29:37 INFO - "pgo_build": "False", 16:29:37 INFO - "basedir": "/builds/slave/test", 16:29:37 INFO - "project": "", 16:29:37 INFO - "platform": "ubuntu64_hw", 16:29:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:29:37 INFO - "slavebuilddir": "test", 16:29:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:29:37 INFO - "branch": "fx-team", 16:29:37 INFO - "repo_path": "integration/fx-team", 16:29:37 INFO - "stage_platform": "linux64", 16:29:37 INFO - "builduid": "b10eb016d3974000aaa3c480f91b874d", 16:29:37 INFO - "revision": "809ef65b4a96cfb02ef3acfdb664fa03394a0195" 16:29:37 INFO - }, 16:29:37 INFO - "sourcestamp": { 16:29:37 INFO - "repository": "", 16:29:37 INFO - "hasPatch": false, 16:29:37 INFO - "project": "", 16:29:37 INFO - "branch": "fx-team-linux64-talos", 16:29:37 INFO - "changes": [ 16:29:37 INFO - { 16:29:37 INFO - "category": null, 16:29:37 INFO - "files": [ 16:29:37 INFO - { 16:29:37 INFO - "url": null, 16:29:37 INFO - "name": "https://queue.taskcluster.net/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 16:29:37 INFO - } 16:29:37 INFO - ], 16:29:37 INFO - "repository": "", 16:29:37 INFO - "rev": "809ef65b4a96cfb02ef3acfdb664fa03394a0195", 16:29:37 INFO - "who": "kwierso@gmail.com", 16:29:37 INFO - "when": 1448064946, 16:29:37 INFO - "number": 6691315, 16:29:37 INFO - "comments": "Merge m-c to fx-team, a=merge", 16:29:37 INFO - "project": "", 16:29:37 INFO - "at": "Fri 20 Nov 2015 16:15:46", 16:29:37 INFO - "branch": "fx-team-linux64-talos", 16:29:37 INFO - "revlink": "", 16:29:37 INFO - "properties": [ 16:29:37 INFO - [ 16:29:37 INFO - "buildid", 16:29:37 INFO - "20151120144638", 16:29:37 INFO - "Change" 16:29:37 INFO - ], 16:29:37 INFO - [ 16:29:37 INFO - "builduid", 16:29:37 INFO - "b10eb016d3974000aaa3c480f91b874d", 16:29:37 INFO - "Change" 16:29:37 INFO - ], 16:29:37 INFO - [ 16:29:37 INFO - "pgo_build", 16:29:37 INFO - "False", 16:29:37 INFO - "Change" 16:29:37 INFO - ] 16:29:37 INFO - ], 16:29:37 INFO - "revision": "809ef65b4a96cfb02ef3acfdb664fa03394a0195" 16:29:37 INFO - } 16:29:37 INFO - ], 16:29:37 INFO - "revision": "809ef65b4a96cfb02ef3acfdb664fa03394a0195" 16:29:37 INFO - } 16:29:37 INFO - } 16:29:37 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:29:37 INFO - Running post-action listener: _resource_record_post_action 16:29:37 INFO - ##### 16:29:37 INFO - ##### Running download-and-extract step. 16:29:37 INFO - ##### 16:29:37 INFO - Running pre-action listener: _resource_record_pre_action 16:29:37 INFO - Running main action method: download_and_extract 16:29:37 INFO - mkdir: /builds/slave/test/build/tests 16:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:37 INFO - https://queue.taskcluster.net/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:29:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/test_packages.json 16:29:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/test_packages.json 16:29:37 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:29:37 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:29:38 INFO - Downloaded 1302 bytes. 16:29:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:29:38 INFO - Using the following test package requirements: 16:29:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:29:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:29:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:29:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:29:38 INFO - u'jsshell-linux-x86_64.zip'], 16:29:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:29:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:29:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:29:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:29:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:29:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:29:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:29:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:29:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:29:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:29:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:29:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:29:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:29:38 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:29:38 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:29:38 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:29:38 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:29:38 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:29:38 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:29:39 INFO - Downloaded 21339409 bytes. 16:29:39 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:29:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:29:39 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:29:40 INFO - Return code: 0 16:29:40 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:29:40 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:29:40 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:29:40 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:29:40 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:29:40 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:29:40 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:29:41 INFO - Downloaded 21339409 bytes. 16:29:41 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:29:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:29:41 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:29:42 INFO - Return code: 0 16:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:42 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:29:42 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:29:42 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:29:42 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:29:42 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:29:43 INFO - Downloaded 11130997 bytes. 16:29:43 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:29:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:29:43 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:29:43 INFO - Return code: 0 16:29:43 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:29:43 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:29:43 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:29:43 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:29:43 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:29:43 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:29:47 INFO - Downloaded 55909406 bytes. 16:29:47 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:29:47 INFO - mkdir: /builds/slave/test/properties 16:29:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:29:47 INFO - Writing to file /builds/slave/test/properties/build_url 16:29:47 INFO - Contents: 16:29:47 INFO - build_url:https://queue.taskcluster.net/v1/task/vUOW2WHCS6asPKCC78ztGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:29:47 INFO - Running post-action listener: _resource_record_post_action 16:29:47 INFO - Running post-action listener: set_extra_try_arguments 16:29:47 INFO - ##### 16:29:47 INFO - ##### Running populate-webroot step. 16:29:47 INFO - ##### 16:29:47 INFO - Running pre-action listener: _resource_record_pre_action 16:29:47 INFO - Running main action method: populate_webroot 16:29:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:29:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:29:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:29:47 INFO - '../fennec_ids.txt'], 16:29:47 INFO - 'tests': ['tcheck2']}, 16:29:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:29:47 INFO - '--tppagecycles', 16:29:47 INFO - '7'], 16:29:47 INFO - 'tests': ['tsvgm']}}, 16:29:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:29:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:29:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:29:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:29:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:29:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:29:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:29:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:47 INFO - 'talos_options': ['--e10s'], 16:29:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:29:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:47 INFO - 'tests': ['damp', 'tps']}, 16:29:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:47 INFO - 'talos_options': ['--e10s'], 16:29:47 INFO - 'tests': ['damp', 'tps']}, 16:29:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:29:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:29:47 INFO - 'other': {'tests': ['a11yr', 16:29:47 INFO - 'ts_paint', 16:29:47 INFO - 'tpaint', 16:29:47 INFO - 'sessionrestore', 16:29:47 INFO - 'sessionrestore_no_auto_restore']}, 16:29:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:29:47 INFO - 'tests': ['a11yr', 16:29:47 INFO - 'ts_paint', 16:29:47 INFO - 'tpaint', 16:29:47 INFO - 'sessionrestore', 16:29:47 INFO - 'sessionrestore_no_auto_restore']}, 16:29:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:29:47 INFO - 'tests': ['a11yr', 16:29:47 INFO - 'ts_paint', 16:29:47 INFO - 'tpaint', 16:29:47 INFO - 'sessionrestore', 16:29:47 INFO - 'sessionrestore_no_auto_restore']}, 16:29:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:29:47 INFO - 'tests': ['a11yr', 16:29:47 INFO - 'ts_paint', 16:29:47 INFO - 'tpaint', 16:29:47 INFO - 'sessionrestore', 16:29:47 INFO - 'sessionrestore_no_auto_restore']}, 16:29:47 INFO - 'other_l64': {'tests': ['a11yr', 16:29:47 INFO - 'ts_paint', 16:29:47 INFO - 'tpaint', 16:29:47 INFO - 'sessionrestore', 16:29:47 INFO - 'sessionrestore_no_auto_restore']}, 16:29:47 INFO - 'other_nol64': {'tests': ['a11yr', 16:29:47 INFO - 'ts_paint', 16:29:47 INFO - 'tpaint', 16:29:47 INFO - 'sessionrestore', 16:29:47 INFO - 'sessionrestore_no_auto_restore']}, 16:29:47 INFO - 'svgr': {'tests': ['tsvgx', 16:29:47 INFO - 'tsvgr_opacity', 16:29:47 INFO - 'tart', 16:29:47 INFO - 'tscrollx', 16:29:47 INFO - 'cart']}, 16:29:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:29:47 INFO - 'tests': ['tsvgx', 16:29:47 INFO - 'tsvgr_opacity', 16:29:47 INFO - 'tart', 16:29:47 INFO - 'tscrollx', 16:29:47 INFO - 'cart']}, 16:29:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:47 INFO - 'tests': ['tp5o']}, 16:29:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:47 INFO - 'talos_options': ['--e10s'], 16:29:47 INFO - 'tests': ['tp5o']}, 16:29:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:47 INFO - 'talos_options': ['--xperf_path', 16:29:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:29:47 INFO - 'tests': ['tp5n']}, 16:29:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:47 INFO - 'talos_options': ['--e10s', 16:29:47 INFO - '--xperf_path', 16:29:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:29:47 INFO - 'tests': ['tp5n']}}, 16:29:47 INFO - 'talos.zip': {'path': '', 16:29:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:29:47 INFO - Running post-action listener: _resource_record_post_action 16:29:47 INFO - ##### 16:29:47 INFO - ##### Running create-virtualenv step. 16:29:47 INFO - ##### 16:29:47 INFO - Running pre-action listener: _resource_record_pre_action 16:29:47 INFO - Running main action method: create_virtualenv 16:29:47 INFO - Creating virtualenv /builds/slave/test/build/venv 16:29:47 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:29:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:29:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:29:47 INFO - Using real prefix '/usr' 16:29:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:29:48 INFO - Installing distribute.............................................................................................................................................................................................done. 16:29:50 INFO - Installing pip.................done. 16:29:50 INFO - Return code: 0 16:29:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:29:50 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:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:50 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:29:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:50 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 0x7f8636370c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1856900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189cb70>, '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 0x18eddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ee250>, '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': '70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785', '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:29:50 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:29:50 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:29:50 INFO - Using env: {'DISPLAY': ':0', 16:29:50 INFO - 'HOME': '/home/cltbld', 16:29:50 INFO - 'LANG': 'en_US.UTF-8', 16:29:50 INFO - 'LANGUAGE': 'en_US:en', 16:29:50 INFO - 'LOGNAME': 'cltbld', 16:29:50 INFO - 'MAIL': '/var/mail/cltbld', 16:29:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:50 INFO - 'MOZ_NO_REMOTE': '1', 16:29:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:50 INFO - 'NO_EM_RESTART': '1', 16:29:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:50 INFO - 'PWD': '/builds/slave/test', 16:29:50 INFO - 'SHELL': '/bin/bash', 16:29:50 INFO - 'SHLVL': '1', 16:29:50 INFO - 'TERM': 'linux', 16:29:50 INFO - 'TMOUT': '86400', 16:29:50 INFO - 'USER': 'cltbld', 16:29:50 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785', 16:29:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:50 INFO - '_': '/tools/buildbot/bin/python'} 16:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:50 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:29:50 INFO - Cleaning up... 16:29:50 INFO - Return code: 0 16:29:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:29:50 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:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:50 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:29:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:50 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 0x7f8636370c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1856900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189cb70>, '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 0x18eddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ee250>, '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': '70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785', '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:29:50 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:29:50 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:29:50 INFO - Using env: {'DISPLAY': ':0', 16:29:50 INFO - 'HOME': '/home/cltbld', 16:29:50 INFO - 'LANG': 'en_US.UTF-8', 16:29:50 INFO - 'LANGUAGE': 'en_US:en', 16:29:50 INFO - 'LOGNAME': 'cltbld', 16:29:50 INFO - 'MAIL': '/var/mail/cltbld', 16:29:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:50 INFO - 'MOZ_NO_REMOTE': '1', 16:29:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:50 INFO - 'NO_EM_RESTART': '1', 16:29:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:50 INFO - 'PWD': '/builds/slave/test', 16:29:50 INFO - 'SHELL': '/bin/bash', 16:29:50 INFO - 'SHLVL': '1', 16:29:50 INFO - 'TERM': 'linux', 16:29:50 INFO - 'TMOUT': '86400', 16:29:50 INFO - 'USER': 'cltbld', 16:29:50 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785', 16:29:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:50 INFO - '_': '/tools/buildbot/bin/python'} 16:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:50 INFO - Downloading/unpacking psutil>=0.7.1 16:29:50 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:29:50 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:29:50 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:29:50 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:29:50 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:29:50 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:29:52 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:29:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:29:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:29:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:29:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:29:52 INFO - Installing collected packages: psutil 16:29:52 INFO - Running setup.py install for psutil 16:29:52 INFO - building 'psutil._psutil_linux' extension 16:29:52 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:29:52 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:29:52 INFO - building 'psutil._psutil_posix' extension 16:29:52 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:29:52 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:29:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:29:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:29:52 INFO - Successfully installed psutil 16:29:52 INFO - Cleaning up... 16:29:52 INFO - Return code: 0 16:29:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:29:52 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:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:52 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:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:52 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 0x7f8636370c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1856900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189cb70>, '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 0x18eddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ee250>, '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': '70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785', '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:29:52 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:29:52 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:29:52 INFO - Using env: {'DISPLAY': ':0', 16:29:52 INFO - 'HOME': '/home/cltbld', 16:29:52 INFO - 'LANG': 'en_US.UTF-8', 16:29:52 INFO - 'LANGUAGE': 'en_US:en', 16:29:52 INFO - 'LOGNAME': 'cltbld', 16:29:52 INFO - 'MAIL': '/var/mail/cltbld', 16:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:52 INFO - 'MOZ_NO_REMOTE': '1', 16:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:52 INFO - 'NO_EM_RESTART': '1', 16:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:52 INFO - 'PWD': '/builds/slave/test', 16:29:52 INFO - 'SHELL': '/bin/bash', 16:29:52 INFO - 'SHLVL': '1', 16:29:52 INFO - 'TERM': 'linux', 16:29:52 INFO - 'TMOUT': '86400', 16:29:52 INFO - 'USER': 'cltbld', 16:29:52 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785', 16:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:52 INFO - '_': '/tools/buildbot/bin/python'} 16:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:29:52 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:29:52 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:29:52 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:29:52 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:29:52 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:29:52 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:29:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:29:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:29:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:29:54 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:29:54 INFO - Installing collected packages: mozsystemmonitor 16:29:54 INFO - Running setup.py install for mozsystemmonitor 16:29:54 INFO - Successfully installed mozsystemmonitor 16:29:54 INFO - Cleaning up... 16:29:55 INFO - Return code: 0 16:29:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:29:55 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:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:55 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:29:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:55 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 0x7f8636370c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1856900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189cb70>, '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 0x18eddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ee250>, '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': '70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785', '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:29:55 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:29:55 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:29:55 INFO - Using env: {'DISPLAY': ':0', 16:29:55 INFO - 'HOME': '/home/cltbld', 16:29:55 INFO - 'LANG': 'en_US.UTF-8', 16:29:55 INFO - 'LANGUAGE': 'en_US:en', 16:29:55 INFO - 'LOGNAME': 'cltbld', 16:29:55 INFO - 'MAIL': '/var/mail/cltbld', 16:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:55 INFO - 'MOZ_NO_REMOTE': '1', 16:29:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:55 INFO - 'NO_EM_RESTART': '1', 16:29:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:55 INFO - 'PWD': '/builds/slave/test', 16:29:55 INFO - 'SHELL': '/bin/bash', 16:29:55 INFO - 'SHLVL': '1', 16:29:55 INFO - 'TERM': 'linux', 16:29:55 INFO - 'TMOUT': '86400', 16:29:55 INFO - 'USER': 'cltbld', 16:29:55 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785', 16:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:55 INFO - '_': '/tools/buildbot/bin/python'} 16:29:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:55 INFO - Downloading/unpacking blobuploader==1.2.4 16:29:55 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:29:55 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:29:55 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:29:55 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:29:55 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:29:55 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:29:56 INFO - Downloading blobuploader-1.2.4.tar.gz 16:29:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:29:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:29:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:29:56 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:29:56 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:29:56 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:29:56 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:29:56 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:29:56 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:29:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:29:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:29:57 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:29:57 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:29:57 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:29:57 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:29:57 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:29:57 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:29:57 INFO - Downloading docopt-0.6.1.tar.gz 16:29:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:29:57 INFO - Installing collected packages: blobuploader, requests, docopt 16:29:57 INFO - Running setup.py install for blobuploader 16:29:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:29:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:29:57 INFO - Running setup.py install for requests 16:29:57 INFO - Running setup.py install for docopt 16:29:58 INFO - Successfully installed blobuploader requests docopt 16:29:58 INFO - Cleaning up... 16:29:58 INFO - Return code: 0 16:29:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:58 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 0x7f8636370c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1856900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189cb70>, '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 0x18eddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ee250>, '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': '70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785', '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:29:58 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:29:58 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:29:58 INFO - Using env: {'DISPLAY': ':0', 16:29:58 INFO - 'HOME': '/home/cltbld', 16:29:58 INFO - 'LANG': 'en_US.UTF-8', 16:29:58 INFO - 'LANGUAGE': 'en_US:en', 16:29:58 INFO - 'LOGNAME': 'cltbld', 16:29:58 INFO - 'MAIL': '/var/mail/cltbld', 16:29:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:58 INFO - 'MOZ_NO_REMOTE': '1', 16:29:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:58 INFO - 'NO_EM_RESTART': '1', 16:29:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:58 INFO - 'PWD': '/builds/slave/test', 16:29:58 INFO - 'SHELL': '/bin/bash', 16:29:58 INFO - 'SHLVL': '1', 16:29:58 INFO - 'TERM': 'linux', 16:29:58 INFO - 'TMOUT': '86400', 16:29:58 INFO - 'USER': 'cltbld', 16:29:58 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785', 16:29:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:58 INFO - '_': '/tools/buildbot/bin/python'} 16:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:29:58 INFO - Running setup.py (path:/tmp/pip-gobDYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:29:58 INFO - Running setup.py (path:/tmp/pip-1qzfWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:29:58 INFO - Running setup.py (path:/tmp/pip-BVanHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:29:58 INFO - Running setup.py (path:/tmp/pip-iL01Jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:29:58 INFO - Running setup.py (path:/tmp/pip-rluiL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:29:58 INFO - Running setup.py (path:/tmp/pip-McsCqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:29:58 INFO - Running setup.py (path:/tmp/pip-z_gx7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:29:58 INFO - Running setup.py (path:/tmp/pip-GrtAaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:29:58 INFO - Running setup.py (path:/tmp/pip-txodAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:29:59 INFO - Running setup.py (path:/tmp/pip-cf7tCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:29:59 INFO - Running setup.py (path:/tmp/pip-R75W1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:29:59 INFO - Running setup.py (path:/tmp/pip-yReHZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:29:59 INFO - Running setup.py (path:/tmp/pip-1K9Yue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:29:59 INFO - Running setup.py (path:/tmp/pip-Jpc0PM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:59 INFO - Running setup.py (path:/tmp/pip-jdx6Me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:29:59 INFO - Running setup.py (path:/tmp/pip-rUz6D_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:29:59 INFO - Running setup.py (path:/tmp/pip-E2mWb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:29:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:29:59 INFO - Running setup.py install for manifestparser 16:29:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:29:59 INFO - Running setup.py install for mozcrash 16:29:59 INFO - Running setup.py install for mozdebug 16:29:59 INFO - Running setup.py install for mozdevice 16:30:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Running setup.py install for mozfile 16:30:00 INFO - Running setup.py install for mozhttpd 16:30:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Running setup.py install for mozinfo 16:30:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Running setup.py install for mozInstall 16:30:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Running setup.py install for mozleak 16:30:00 INFO - Running setup.py install for mozlog 16:30:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Running setup.py install for moznetwork 16:30:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Running setup.py install for mozprocess 16:30:00 INFO - Running setup.py install for mozprofile 16:30:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Running setup.py install for mozrunner 16:30:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:30:01 INFO - Running setup.py install for mozscreenshot 16:30:01 INFO - Running setup.py install for moztest 16:30:01 INFO - Running setup.py install for mozversion 16:30:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:30:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:30:01 INFO - Cleaning up... 16:30:01 INFO - Return code: 0 16:30:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:30: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:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30: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:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:01 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 0x7f8636370c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1856900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189cb70>, '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 0x18eddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ee250>, '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': '70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785', '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:30:01 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:30:01 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:30:01 INFO - Using env: {'DISPLAY': ':0', 16:30:01 INFO - 'HOME': '/home/cltbld', 16:30:01 INFO - 'LANG': 'en_US.UTF-8', 16:30:01 INFO - 'LANGUAGE': 'en_US:en', 16:30:01 INFO - 'LOGNAME': 'cltbld', 16:30:01 INFO - 'MAIL': '/var/mail/cltbld', 16:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:01 INFO - 'MOZ_NO_REMOTE': '1', 16:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:01 INFO - 'NO_EM_RESTART': '1', 16:30:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:01 INFO - 'PWD': '/builds/slave/test', 16:30:01 INFO - 'SHELL': '/bin/bash', 16:30:01 INFO - 'SHLVL': '1', 16:30:01 INFO - 'TERM': 'linux', 16:30:01 INFO - 'TMOUT': '86400', 16:30:01 INFO - 'USER': 'cltbld', 16:30:01 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785', 16:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:01 INFO - '_': '/tools/buildbot/bin/python'} 16:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:30:01 INFO - Running setup.py (path:/tmp/pip-MXlH6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:30:01 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:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:30:01 INFO - Running setup.py (path:/tmp/pip-6WWJfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:30:01 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:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:30:01 INFO - Running setup.py (path:/tmp/pip-G5kqNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:30:01 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:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:30:01 INFO - Running setup.py (path:/tmp/pip-ZbRxv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:30:01 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:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:30:01 INFO - Running setup.py (path:/tmp/pip-pb5cUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:30:01 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:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:30:01 INFO - Running setup.py (path:/tmp/pip-qqfrC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:30:02 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:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:30:02 INFO - Running setup.py (path:/tmp/pip-yl6g_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:30:02 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:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:30:02 INFO - Running setup.py (path:/tmp/pip-5SNvQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:30:02 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:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:30:02 INFO - Running setup.py (path:/tmp/pip-6l0UFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:30:02 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:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:30:02 INFO - Running setup.py (path:/tmp/pip-fiPWiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:30:02 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:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:30:02 INFO - Running setup.py (path:/tmp/pip-Q5zZbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:30:02 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:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:30:02 INFO - Running setup.py (path:/tmp/pip-31nGzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:30:02 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:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:30:02 INFO - Running setup.py (path:/tmp/pip-slojbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:30:02 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:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:30:02 INFO - Running setup.py (path:/tmp/pip-jIYnMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:30:02 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:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:30:02 INFO - Running setup.py (path:/tmp/pip-bsyLai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:30:02 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:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:30:02 INFO - Running setup.py (path:/tmp/pip-OjLAvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:30:02 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:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:30:02 INFO - Running setup.py (path:/tmp/pip-7GMNv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:30:02 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:30:02 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:30:02 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:30:02 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:30:02 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:30:02 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:30:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:30:02 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:30:02 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:30:02 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:30:02 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:30:02 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:30:02 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:30:04 INFO - Downloading blessings-1.5.1.tar.gz 16:30:04 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:30:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:30:04 INFO - Installing collected packages: blessings 16:30:04 INFO - Running setup.py install for blessings 16:30:04 INFO - Successfully installed blessings 16:30:04 INFO - Cleaning up... 16:30:04 INFO - Return code: 0 16:30:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:30:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:30:04 INFO - Reading from file tmpfile_stdout 16:30:04 INFO - Current package versions: 16:30:04 INFO - argparse == 1.2.1 16:30:04 INFO - blessings == 1.5.1 16:30:04 INFO - blobuploader == 1.2.4 16:30:04 INFO - docopt == 0.6.1 16:30:04 INFO - manifestparser == 1.1 16:30:04 INFO - mozInstall == 1.12 16:30:04 INFO - mozcrash == 0.16 16:30:04 INFO - mozdebug == 0.1 16:30:04 INFO - mozdevice == 0.47 16:30:04 INFO - mozfile == 1.2 16:30:04 INFO - mozhttpd == 0.7 16:30:04 INFO - mozinfo == 0.9 16:30:04 INFO - mozleak == 0.1 16:30:04 INFO - mozlog == 3.0 16:30:04 INFO - moznetwork == 0.27 16:30:04 INFO - mozprocess == 0.22 16:30:04 INFO - mozprofile == 0.27 16:30:04 INFO - mozrunner == 6.11 16:30:04 INFO - mozscreenshot == 0.1 16:30:04 INFO - mozsystemmonitor == 0.0 16:30:04 INFO - moztest == 0.7 16:30:04 INFO - mozversion == 1.4 16:30:04 INFO - psutil == 3.1.1 16:30:04 INFO - requests == 1.2.3 16:30:04 INFO - wsgiref == 0.1.2 16:30:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:04 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 0x7f8636370c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1856900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189cb70>, '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 0x18eddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ee250>, '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': '70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785', '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:30:04 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:30:04 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:30:04 INFO - Using env: {'DISPLAY': ':0', 16:30:04 INFO - 'HOME': '/home/cltbld', 16:30:04 INFO - 'LANG': 'en_US.UTF-8', 16:30:04 INFO - 'LANGUAGE': 'en_US:en', 16:30:04 INFO - 'LOGNAME': 'cltbld', 16:30:04 INFO - 'MAIL': '/var/mail/cltbld', 16:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:04 INFO - 'MOZ_NO_REMOTE': '1', 16:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:04 INFO - 'NO_EM_RESTART': '1', 16:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:04 INFO - 'PWD': '/builds/slave/test', 16:30:04 INFO - 'SHELL': '/bin/bash', 16:30:04 INFO - 'SHLVL': '1', 16:30:04 INFO - 'TERM': 'linux', 16:30:04 INFO - 'TMOUT': '86400', 16:30:04 INFO - 'USER': 'cltbld', 16:30:04 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785', 16:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:04 INFO - '_': '/tools/buildbot/bin/python'} 16:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:05 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:30:05 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:30:05 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:30:05 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:30:05 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:30:05 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:30:05 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:30:05 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:30:05 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:30:05 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:30:05 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:30:05 INFO - Cleaning up... 16:30:05 INFO - Return code: 0 16:30:05 INFO - Running post-action listener: _resource_record_post_action 16:30:05 INFO - Running post-action listener: _start_resource_monitoring 16:30:05 INFO - Starting resource monitoring. 16:30:05 INFO - ##### 16:30:05 INFO - ##### Running install step. 16:30:05 INFO - ##### 16:30:05 INFO - Running pre-action listener: _resource_record_pre_action 16:30:05 INFO - Running main action method: install 16:30:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:30:05 INFO - Reading from file tmpfile_stdout 16:30:05 INFO - Detecting whether we're running mozinstall >=1.0... 16:30:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:30:05 INFO - Reading from file tmpfile_stdout 16:30:05 INFO - Output received: 16:30:05 INFO - Usage: mozinstall [options] installer 16:30:05 INFO - Options: 16:30:05 INFO - -h, --help show this help message and exit 16:30:05 INFO - -d DEST, --destination=DEST 16:30:05 INFO - Directory to install application into. [default: 16:30:05 INFO - "/builds/slave/test"] 16:30:05 INFO - --app=APP Application being installed. [default: firefox] 16:30:05 INFO - mkdir: /builds/slave/test/build/application 16:30:05 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:30:05 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:30:19 INFO - Reading from file tmpfile_stdout 16:30:19 INFO - Output received: 16:30:19 INFO - /builds/slave/test/build/application/firefox/firefox 16:30:19 INFO - Running post-action listener: _resource_record_post_action 16:30:19 INFO - ##### 16:30:19 INFO - ##### Running run-tests step. 16:30:19 INFO - ##### 16:30:19 INFO - Running pre-action listener: _resource_record_pre_action 16:30:19 INFO - Running main action method: run_tests 16:30:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:30:19 INFO - Python 2.7.3 16:30:19 INFO - Return code: 0 16:30:19 INFO - grabbing minidump binary from tooltool 16:30: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:30:19 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 0x189cb70>, '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 0x18eddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ee250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:30:19 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:30:19 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:30:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:30:19 INFO - Return code: 0 16:30:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:30:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:30:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:30:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:30:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:30:19 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-e10s', '--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-015', '--webServer', 'localhost'] in /builds/slave/test/build 16:30:19 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-e10s --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-015 --webServer localhost 16:30:19 INFO - Using env: {'DISPLAY': ':0', 16:30:19 INFO - 'HOME': '/home/cltbld', 16:30:19 INFO - 'LANG': 'en_US.UTF-8', 16:30:19 INFO - 'LANGUAGE': 'en_US:en', 16:30:19 INFO - 'LOGNAME': 'cltbld', 16:30:19 INFO - 'MAIL': '/var/mail/cltbld', 16:30:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:30:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:19 INFO - 'MOZ_NO_REMOTE': '1', 16:30:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:19 INFO - 'NO_EM_RESTART': '1', 16:30:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:19 INFO - 'PWD': '/builds/slave/test', 16:30:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:30:19 INFO - 'SHELL': '/bin/bash', 16:30:19 INFO - 'SHLVL': '1', 16:30:19 INFO - 'TERM': 'linux', 16:30:19 INFO - 'TMOUT': '86400', 16:30:19 INFO - 'USER': 'cltbld', 16:30:19 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785', 16:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:19 INFO - '_': '/tools/buildbot/bin/python'} 16:30:19 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-e10s', '--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-015', '--webServer', 'localhost'] with output_timeout 3600 16:30:19 INFO - mozversion INFO | application_buildid: 20151120144638 16:30:19 INFO - mozversion INFO | application_changeset: 809ef65b4a96cfb02ef3acfdb664fa03394a0195 16:30:19 INFO - mozversion INFO | application_display_name: Nightly 16:30:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:30:19 INFO - mozversion INFO | application_name: Firefox 16:30:19 INFO - mozversion INFO | application_remotingname: firefox 16:30:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:30:19 INFO - mozversion INFO | application_vendor: Mozilla 16:30:19 INFO - mozversion INFO | application_version: 45.0a1 16:30:19 INFO - mozversion INFO | platform_buildid: 20151120144638 16:30:19 INFO - mozversion INFO | platform_changeset: 809ef65b4a96cfb02ef3acfdb664fa03394a0195 16:30:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:30:19 INFO - mozversion INFO | platform_version: 45.0a1 16:30:19 INFO - 2015-11-20 16:30:19,823 DEBUG : using testdate: 1448065819 16:30:19 INFO - 2015-11-20 16:30:19,823 DEBUG : actual date: 1448065819 16:30:19 INFO - 2015-11-20 16:30:19,908 INFO : starting webserver on 'localhost:35609' 16:30:19 INFO - 2015-11-20 16:30:19,909 INFO : Starting test suite talos-linux64-ix-015.e 16:30:19 INFO - 2015-11-20 16:30:19,909 INFO : Starting test dromaeo_css 16:30:19 INFO - 2015-11-20 16:30:19,910 DEBUG : operating with platform_type : linux_ 16:30:19 INFO - 2015-11-20 16:30:19,910 INFO : Initialising browser for dromaeo_css test... 16:30:19 INFO - 2015-11-20 16:30:19,923 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP1vWzS/profile http://localhost:35609/getInfo.html 16:30:24 INFO - 2015-11-20 16:30:24,972 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:30:24 INFO - 2015-11-20 16:30:24,972 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:30:24 INFO - 2015-11-20 16:30:24,973 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:30:24 INFO - 2015-11-20 16:30:24,973 DEBUG : BROWSER_OUTPUT: __metrics 16:30:26 INFO - 2015-11-20 16:30:26,045 INFO : Browser initialized. 16:30:26 INFO - 2015-11-20 16:30:26,046 INFO : Running cycle 1/1 for dromaeo_css test... 16:30:26 INFO - 2015-11-20 16:30:26,046 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP1vWzS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:30:37 INFO - 2015-11-20 16:30:37,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 141914112 16:30:37 INFO - 2015-11-20 16:30:37,922 DEBUG : BROWSER_OUTPUT: 16:31:27 INFO - 2015-11-20 16:31:27,574 DEBUG : BROWSER_OUTPUT: 1448065887567 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:33:39 INFO - 2015-11-20 16:33:39,921 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35609/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35609/tests/dromaeo/cssquery-ext.html) 16:33:40 INFO - 2015-11-20 16:33:40,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 144084992 16:33:40 INFO - 2015-11-20 16:33:40,905 DEBUG : BROWSER_OUTPUT: 16:36:42 INFO - 2015-11-20 16:36:42,915 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35609/tests/dromaeo/cssquery-ext.html (next: http://localhost:35609/tests/dromaeo/cssquery-jquery.html) 16:36:43 INFO - 2015-11-20 16:36:43,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 143441920 16:36:43 INFO - 2015-11-20 16:36:43,501 DEBUG : BROWSER_OUTPUT: 16:39:45 INFO - 2015-11-20 16:39:45,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35609/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35609/tests/dromaeo/cssquery-mootools.html) 16:39:45 INFO - 2015-11-20 16:39:45,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 142561280 16:39:45 INFO - 2015-11-20 16:39:45,797 DEBUG : BROWSER_OUTPUT: 16:42:47 INFO - 2015-11-20 16:42:47,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35609/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35609/tests/dromaeo/cssquery-prototype.html) 16:42:48 INFO - 2015-11-20 16:42:48,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 141549568 16:42:48 INFO - 2015-11-20 16:42:48,137 DEBUG : BROWSER_OUTPUT: 16:45:50 INFO - 2015-11-20 16:45:50,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35609/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35609/tests/dromaeo/cssquery-yui.html) 16:45:51 INFO - 2015-11-20 16:45:51,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 142098432 16:45:51 INFO - 2015-11-20 16:45:51,353 DEBUG : BROWSER_OUTPUT: 16:48:53 INFO - 2015-11-20 16:48:53,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35609/tests/dromaeo/cssquery-yui.html (next: http://localhost:35609/tests/dromaeo/cssquery-dojo.html) 16:48:53 INFO - 2015-11-20 16:48:53,858 DEBUG : BROWSER_OUTPUT: RSS: Main: 144125952 16:48:53 INFO - 2015-11-20 16:48:53,858 DEBUG : BROWSER_OUTPUT: 16:48:53 INFO - 2015-11-20 16:48:53,858 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:48:53 INFO - 2015-11-20 16:48:53,859 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:48:53 INFO - 2015-11-20 16:48:53,859 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:48:53 INFO - 2015-11-20 16:48:53,859 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:48:53 INFO - 2015-11-20 16:48:53,862 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2674.251209661295;2731.931701707458;2742.0676969830256;2749.862506874657;2756.4349308391784;4542.750148741818;4764.928526072107;4767.928481072782;4792.90414191716;4810.182269014267;4621.930671039937;4641.396618439599;4699.365585645936;4753.263244197146;4778.80884764609;4349.456317960255;4349.630281426083;4386.868393948171;4407.07451435199;4445.155420470101;4463.018136010072;4492.348609451627;4510.594046535811;4515.525869783674;4521.638268938477;4182.686298527623;4228.048689044971;4263.658907287409;4369.453818272716;4441.356003379508;4396.582324679182;4406.228909940747;4416.072624748806;4417.315316126005;4448.266036104039;4397.494288156871;4403.603675669206;4410.889727756799;4433.6009759121835;4448.955510444886;4488.326750987346;4571.58855702985;4611.30830375443;4712.6229901607785;4714.787834547454;5099.15863882459;5131.153359695646;5150.68657492337;5153;5198.584113270929;4892.608591312722;5148.819791307324;5150.4334523202415;5169.172932330809;5182.559482443997;4647.814087436533;4678;4715.174844402216;4718.339432479455;4754.7147171169845;5206.193040078794;5225.947740522546;5254.133068043807;5263.868403289948;5291.656042357235;4774.427068751703;4857.635677324144;4998.150314446553;5003.3495645565845;5028.7737051832755;4996.15065438869;5006.974965125151;5100.030994111107;5105.591552675852;5154.819581314636;5079.085764562415;5079.517445842639;5092.236164575269;5096.210087436453;5134.768935397916;4770.189067858472;4874.390701162355;5061.822836200715;5084.720340381315;5089.00764350948;4183.477065366829;4255.4255175551525;4260.403543503912;4301.41930839339;4303.440552728125;3764.3600587900123;3773.0755964788805;3773.716971227169;3800.3539398302355;3815.790131542736;4204.726692764961;4292.463442069741;4336.154449882306;4430.756308403069;4461.910761784746;5108.540231379119;5120.769565369567;5147.176451767699;5151.845444636667;5158.587313014949;4450.221211288076;4454.643628509712;4461.04087621163;4461.196984542814;4494;4330.350447432847;4446.644268458515;4468.977655111768;4558.247889098262;4651.232546629836;4839.975800120977;4842.661013729075;4843.951560484421;4844.224924012141;4859.781309841136;5060.746962651926;5069.645124841226;5072.28987941681;5094.363204599425;5125.410577783603;4649.744264065509;4767.904641907212;4783.521647835189;4854.466008738966;4897.363342765418;5023.723695196799;5088.542031217208;5110;5110.9488905110475;5148.742562871917;4882.584980276574;5123.590112790893;5180.896382072413;5181.81863634771;5190.6626069306885;4843.782029808737;4856.441509226484;4915.557599816034;4928.975355123202;4950.034743225036;4894.388201474816;4908.042931628298;4909.140900342497;4943.431505376784;4957.900841983213;4568.291914753218;4707.411573553306;4796.544328288807;4832.613390928787;4874.390701162355;4875.926861097016;4933.654644174873;4951.455339912679;4953.3065370848835;4956.677815941952;4832.323474713473;4864.246041863516;4895.877603059952;4901.9264711028645;4939.98730260303 16:48:53 INFO - 2015-11-20 16:48:53,862 DEBUG : BROWSER_OUTPUT: |1;ext.html;532.9014132385508;563.0625009359417;566.9546436285099;567.7445149682644;588.4204059001885;28059.57910631342;37453;37711.245775084484;37893.24213515728;37997.81001094998;40350.59649403505;40896.18207635853;40989.18021639565;41067.794661026724;41136.38295425571;7936.920630793705;8097.473664211808;8101;8101.95949020257;8113.594320283992;7945.205479452037;7990.960045199795;8028.879566806473;8039.356851451899;8044.155363686817;7986.440949133563;8039.356851451899;8062.475939063971;8066.193380661945;8071.112177660452;7960.641771120314;8030.919690803075;8035.5580443075605;8043.718469853527;8075.475094118922;7932.246436588515;7976.601169941479;7986.401019923529;8028.317593004544;8050.194980501961;37797;37868.62131378706;37949.810250948845;38441.03897402559;38484;2924.4882145624642;3005.684403137661;3170.4768713162302;3339.1985923378456;3461.6538346165435;27783.86108069467;27851.164465066082;28265.434691306265;28284.85857570699;28673;3360.2775403288165;3371.561696979377;3415.453527435623;3464.7574669773126;3563.4033690902534;228685;231305;231365;231435.8428207865;231780;52875.73562132242;53984.190237146475;56759;62789.68605156945;63866;57412;57853.42146578564;57969.42030579725;58142.7092864533;58150;12251.448684809027;12412.62762117138;12428.254304741744;12435.626931192079;12487.125901187012;8954.597043132944;9103.590338434786;9176.403533770417;9198.264138868875;9202.723918282461;19129.810496717073;19578.412647620593;19620;19645.607087858447;19765.802341976683;7825.843483130306;8029.397795165269;8037.35701143907;8143.307818835347;8165.346772258205;825.3026192867018;833.8582440985047;866.7616405488415;946.8532377481501;976.3556053004983;30302.69697303043;30329.848350758104;30760.846195768878;31302.530462043087;31501.842490787858;906.551257127726;921.4517362169498;922.4557511068501;931.7158266728712;938.6902322233647;13289.734205316034;13431.059825812295;13460.528881489297;15283.38866445352;16129;337035;343152;343231;345056;346919;48448.5155148444;48792.756036219595;48841.51158488441;48978.26532601943;49020.754896226004;1180.6753142885775;1197.6586672798385;1200.7778560966249;1202.6572426858304;1209.7761914046105;27302.72697273002;28149.43701126007;28184.577231341136;29675.406491870475;29920.55119173258;41726.37410438906;42941.35587966246;43045.56954430541;43073.78463107665;43074.78462607667;252397;254636;256427;257476;257841;39173.608263917;39175;39350.2129957405;39350.80324598359;40017.79991100142;36097.458538122475;38075;38306.2338753229;40658.79670601746;41478.37782433326;33775.4933676;34175;34421;34436.278186090094;34550.30899382049;33704.3259134811;34601.653983459844;34652.48021279733;34733.47899781455;34890.65109348874;34073.82963085169;34411.82794086014;34637.65362346344;34854.30291394208;34899;30353.24116897095;30686.386272274874;31623.525647114853;31692.524612130375;31777;24122;24305;24350.87824560866;24468.388290292885;24508.26475205747 16:48:53 INFO - 2015-11-20 16:48:53,864 DEBUG : BROWSER_OUTPUT: |2;jquery.html;342.8080275045974;343.159259813457;345.03218472185523;347.04735501049623;348.3294657783766;15008.549743507698;15062;15659.60850978726;15899.28453219605;16395.83604163958;10154.74613134672;10331.845022324671;13481.3259337033;14882.851171488282;14969.550913472613;4471.105778844228;4589.839355622554;4597.747123908183;5034.899302013958;5208.166693329068;5145.974270128644;5179;5185.118529849935;5186;5193.376794784631;4905.705657660552;5071.036503064424;5096.770645320969;5138.768755406016;5253.9474605253845;5039.546440820307;5084.618653600976;5088.847334579968;5093.567046801008;5111.156659151254;5019.3976722793495;5024.79900803971;5025.045241404122;5040.6471546991725;5053.545180933696;11279.984801367917;11282.492287846984;11456.083513318914;11458.598949036827;11515.942420287929;1825.3428765644358;1839.9908000460046;1865.020864046373;1904.7238150468243;1957.921683132673;8979.820403591957;9121.680741174094;9392;9401.24790016797;10724.463776811128;1603.5029140966337;1686.502481767869;1712.940047098358;1736.6700326937842;1750.5252074631846;54010;55831.16253256204;56007.71996140034;56392.436075639125;56735.43264567343;9422.575984080733;9679.9032009679;9801.11789938909;9820.65627703027;9882.4564648945;12338.259704417764;12399.13206075566;12412;12434.191777534432;12461.93769031149;6632.602043877287;6682.933170668328;6714.496412768965;6742.696578653972;6749.122614060141;6073.665948372882;6159.784407545714;6164.445199931938;6263.997760358321;6292;3961.3463778476803;4083.305838007546;4141.109661422748;4146.937795933003;4167.979160104241;1742.7560141580188;1757.7099778536399;1772.955676108082;1778.9644207116044;1806.765120534322;412.6100834711229;800.6797281087612;806.9596520173968;898.6046139698511;915.1260546178383;9400.435973841591;9609.90390096104;9798.265130115127;9845.80308393828;9863.309568330147;409.25924077419967;420.31278859065645;426.9146170765859;427.4165763732483;435.34697953070395;5348.973255133699;5409.675419474844;5454.4545545445935;5504.366997795225;5541.0580201365865;478919;487199;495322;502784;503397;68501.57492125373;68746;69624;69808.65095674591;69846.30153698499;463.39064130668066;466.1981392005745;467.632908167094;468.1666633392567;469.40854523300203;9339.533023348942;9411.52942352866;9659;9668.70993870157;9697;29204.853975729984;29429.411411771216;30168.69831301659;30189.245268868453;31403;38295;41364.586354136074;41624.375634366115;42024.57975420329;45076.041635419424;8706.695265665672;8708.912910871064;8725.25835303981;8803.075677053817;8888.688895888612;10400.791984160123;10432.791344173225;10474.895251047392;10522.053015228666;10595.788084238426;13287.933560332136;13432.798508022192;13454.865451345362;13693.246871422167;13824.792628110385;13264.80102798478;13373.331333433483;13413.463461461432;13564.186148831102;13675.179489230679;13791.586252412444;13805.51680691171;14073.929630351782;14094.083884547472;14403.351849166604;8754.430961987451;8794.164554367326;8895.777605559913;8901.376903616685;8908.465492070496;12724.554640587536;12732.809007864704;13486;13738.450461981409;14137.293135343398 16:48:53 INFO - 2015-11-20 16:48:53,865 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1488.9354111810053;1590.4194968836375;1665.933362665493;1673.7656728058073;1703.454894433781;5510.504054635082;5614.27014488117;6276.46650034747;6751.932480675192;6767.796966091019;6370.044493326003;6409.13476680648;6439.517036222279;6475.90286145707;6498.675066246692;1982.861199716017;2025.6556385414515;2028.0265472573174;2028.2191356327846;2033.5526184239518;2015.768186658531;2024.564718585504;2029.2796057399632;2070.596233734415;2074.7406574178226;2022.8078332558457;2046.355398049617;2069.9172033118657;2072.316135675231;2072.336852207294;2037.74528183977;2056.3008577083788;2059.9588008239753;2060.7527096748336;2061.9793802061936;2030.2082187946712;2037.7962203779653;2068.565601223745;2071.616750901088;2080.9479763005893;6542.836429089263;6622.470202383798;6631.204255489372;6631.867362652768;6635.402813746786;3992.480977472939;4024.9597504024878;4039.939400908989;4040.0909795296116;4041.009952561612;2675.8929642814264;2684.181324695967;2695.5417579011614;2744.794140439455;2752.0642981386427;838.5178522349673;846.3525403066659;852.40757673417;868.4832524647887;874.9212570868589;8387.245147936716;8459.873101903477;8486.236238738482;8514.574271286472;8558.101399353041;3766.8681596144;3778.7732736035928;3803.2963901678277;3804.8097595120134;3841.1357444574746;7547.849043019219;7635.121960974559;7635.961820190863;7638.732644357421;7648.885266721004;3961.5840336764227;3966.5636779954184;3970.7220494565104;3984.780837053932;3986.242613903349;3575.0526110580718;3590.784552926833;3597.586277578112;3725.590185079639;3741.8503259869844;3194.2493514024186;3201.167696398953;3220.806751594865;3231.9838400807844;3236.6116066072223;953.2421724728857;956.5408603870181;961.9134277915022;988.5946761827616;989.3766926836047;858.2018722587928;891.157855826251;1150.367297986121;1151.37825574189;1167.620523329921;6209.751609935643;6214.502839772807;6255.687215639291;6287.842803929939;6314.526410519229;1025.477006726575;1025.5948900184385;1042.9426381548935;1059.6397224943555;1086.21792309537;5022.723750193702;5026.346574945233;5040.143175660147;5065.696058236517;5080.949190508121;7609.239076092457;7661.961690191625;7705.036870391201;7928.445008849325;7969.681212751425;7786.493877898032;7802.570858602831;7869.685212591547;7877.487963282369;7877.842443151105;6126.448619624166;6217.720202590895;6246.906296405557;6250;6251.812445626548;5908.438698323653;5937.465628093492;5942;5952.226210592768;5959.821205363846;6868.107146070979;6993.125859267591;7046.401055910305;7133.785986420416;7167.749128780468;7119.466040046914;7228.349448549656;7231.096112985877;7281.5631062136445;7308.926910730825;5315.04329220744;5382.30030096085;5396.271503346998;5967.850803729942;6181.629102253879;6064.241969753781;6143.754249830135;6158.230221222348;6165.815025549241;6194.907076393768;5905.793297234748;6040.607360521552;6062.484688801501;6154.661493617894;6178.320384757583;5906.763729450946;5966.433188847052;6052.848678783065;6074.817755467343;6150.384961503813;5900.498457631149;5957.255343082114;6019.819405417845;6041.033434650435;6064.727087281171;5517.36550296721;5524.861878453071;5532.253145825262;5534.1145416733125;5544.97227513876;5391.541718953776;5755.827325180251;5774.740136693775;5785.595008349375;5813.447722466359 16:48:53 INFO - 2015-11-20 16:48:53,866 DEBUG : BROWSER_OUTPUT: |4;prototype.html;306.6488870243571;315.3550988229071;317.40169779964776;318.25052002534034;320.3656759615962;5486.533644640201;5604.439556044394;5613.719314034302;5670.574706896984;5677.687727174998;5360.410354860972;5506.339239291291;5546.556275497961;5546.91679624805;5559.8888022239535;4326.329418940054;4334.653227741789;4378.71538350007;4393.340998850166;4398.714083584573;4376.474823021226;4377.518472967971;4384.583464570861;4399.274119770234;4399.944013436768;4176.519700234481;4251.893702657428;4341.522432532419;4349.43457350544;4364.607185353318;4277.123189746095;4296.2481565725875;4302.913941721179;4305.246581848164;4307.719998200107;3749.8687545936036;3751.8499260029566;3752.080740218664;3756.868509602178;3758.586555478895;5412.621116521845;5420.7018613976215;5427.240186373911;5430.348358197002;5436.130219164954;4829.517048295177;4871.269309603553;4953.43035550909;4953.752312384402;4964.255361695738;5733.455321744427;5859.150423188614;5872.207252020965;5873.207117039187;5880.5883588148845;4062.8984275393054;4064.4106604542176;4071.9592804071876;4075.266452038632;4084.5098588169312;6114.816555503342;6171.845703857394;6203.751849925998;6205.472534834499;6210.347913469066;4076.103257283393;4162.83348666056;4169.478815148106;4187.413762073312;4193.266178418765;4249.086446414036;4250.681198910094;4256.297710877732;4258.850940217078;4274.700770946066;4884.291777692215;4889.779959901742;4897.240927656219;4902.093112774077;4912.484189160086;5812.331581868139;5844.357120716718;5867.090600956859;5875.265591801025;5885.234919460443;1466.596685911383;1492.060002198608;1512.2589930933984;1514.681916797485;1516.5526169779941;1009.0615727373466;1012.427978192319;1012.9971328384993;1016.6340117557673;1021.6526381030337;5100.948990510122;5121.4622464641425;5123.052235336475;5132.204508301219;5133.743312834344;6071.332153463116;6091.14723938649;6095.116208149882;6096.055111457731;6096.8780624388155;5085.618578606619;5098.056859481007;5120.052790233819;5121.231815227746;5124.15451450514;3224.596925384327;3270.640229574745;3298.983505082459;3301.5542901707963;3301.818399988024;5733.111367738007;5742.3396309424115;5750.108733146369;5753.913691294634;5759;6246.6876656167005;6273.153124328157;6276.717547710364;6280.874382512324;6292.874142517124;5719.113537401709;5730.5129064030025;5731.598788084877;5833.095870140135;5850.414958504116;6110.388961103854;6126.264848218242;6151.661658608819;6192.133101365723;6217;5990.101484777319;6007.369226231182;6018.8194354169445;6031.819045428644;6035.305939816802;5686.829395118153;5812.505936995402;5813.79651712188;5827.533797296291;5834.474897259267;4108.609682080198;4182.832686692498;4188.602082802129;4191.455110835572;4203.054312779723;6124.234470691164;6140.4473597376455;6152.723127459186;6154.969225153845;6156.445919867234;5874.735636896265;5893.351731309467;5900.173975643327;5917.289925209003;5917.91123133162;5748.310202775694;5910.349861515316;5921.171036055042;5940.108983652487;5953.434423729739;5780.797672081457;5809.070548712186;5809.244798176379;5810.273715785527;5823.039198532195;5942.1978032965;5951.345352011189;5981.700914954148;5984.760609575568;5996.970015149896;5690.544756419559;5768.134779783066;5815.302163740378;5830.708464576669;5837 16:48:53 INFO - 2015-11-20 16:48:53,867 DEBUG : BROWSER_OUTPUT: |5;yui.html;693.8092024693209;710.9040279562257;800.1638287989052;802.2458888644674;818.9353840007988;11802.940985295072;12199.573014944479;12214.877851221485;12251.877481225185;12256.387180640966;13643.522476713317;13714.519991800289;13914.721705565908;13970.37133329;13978.3709733062;772.7179579453515;793.0879488588126;796.0845028217539;808.4300568099505;809.1018968944467;801.7835184500182;809.2393150438598;813.6460639621783;814.8533264012475;817.9263866252036;836.4186890111375;842.692417267699;843.0684094076049;844.0630899701326;845.0577605969331;822.8066404394963;823.7199352220244;828.5525816059321;829.4318391901567;836.6402446947841;611.3153268339444;614.7602435050334;617.1883972576048;618.2827919613227;620.4663988969482;11731.88268117325;11741.29552226869;11877.109216808687;11882.88117118835;11884.821727674092;10736.73158171044;11148.662160540705;11318.158019397159;11597.246178998423;12011.399430028463;9526.809463810754;9676.806463870753;9795.902040979641;9871.703848884545;10749.408782517037;3219.0955874302067;3255.5279484474618;3268.346330733863;3272.803631782077;3371;42300;43506.347404788954;43546.56453435457;43769;43818.56181438177;9121.726348209564;9141.81716365669;9467.195288400562;9576.425414475014;9690.70927872165;16659;17201.827981720024;17204.397846075328;17249.741253881202;17281.56796080108;6409.935900641027;6463.935360646427;6644.534882558271;6657.1345725055435;6816.4546836252985;3634.6910512606723;3699.2601479704167;3702.9259414811554;3706.592274849764;3710.8330125144435;2636.973630263673;2642.63003179555;2650.628911952328;2667.7465640764094;2679.276595319253;470.11148928525114;477.672794136011;481.39584821049357;508.0220575392355;524.3210042994332;456.77617967195835;492.17806263539256;533.5224973648562;563.8666280775589;621.7699451202993;7486.625668716542;7651.3496352809525;8409.957950210332;8742;8907.910920890838;585.1982783586428;605.7607245138146;611.4955161991375;620.5532016947881;645.1935081148564;3752.2683076799763;3850.8844734658005;3936.70088870672;4012.378081397388;4012.478377810866;54927.72536137294;55275.44724552703;55710;55837;56218.71890640521;47715.76142119337;48098.5522274958;48247.27629085567;48826.51173488291;48853;44244.336334955;44318.33522497165;44762.77618611951;44885.326720099874;44888;7792.10390805042;7816.452848300564;8187.181281871765;8363.456375335583;8449.95775021121;31183.84408077945;31788;32251.35497290088;33589.66410335866;34453.65546344605;41043.179136416504;41241.381379279934;41948;42281.154376911676;42524;10226.795464090825;10345.948270258601;10356.585736570452;10379.01399367059;10643.521041552995;11105.500252488497;11296.4045089726;11404.885951140383;11803.940980295043;11837.82243266369;11024.559017639525;11118.277311974696;11206.607768728381;11309.151813614177;11386.772264554827;11011.814071983223;11088.556457741923;11186.706660574802;11246.943765281449;11313.321200727984;10404.843927341248;10616.256862019585;10772.676819695422;10818.404987725751;10858.34849909008;9218.677346292847;9310.162085412345;9322.347435679438;9536.284778641768;9571.234301256021;7944.602769861599;8643.87034194475;8686.52224127679;8838.77903052403;8994.910050899407 16:48:53 INFO - 2015-11-20 16:48:53,867 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:48:53 INFO - 2015-11-20 16:48:53,868 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:48:53 INFO - 2015-11-20 16:48:53,868 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,322 16:48:53 INFO - 2015-11-20 16:48:53,868 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:48:53 INFO - 2015-11-20 16:48:53,868 DEBUG : BROWSER_OUTPUT: __startTimestamp1448066933856__endTimestamp 16:48:53 INFO - 2015-11-20 16:48:53,868 DEBUG : BROWSER_OUTPUT: 16:48:53 INFO - 2015-11-20 16:48:53,868 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:48:53 INFO - 2015-11-20 16:48:53,868 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:48:53 INFO - 2015-11-20 16:48:53,868 DEBUG : BROWSER_OUTPUT: 16:48:53 INFO - 2015-11-20 16:48:53,868 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4694.02 Median:4810.18 stddev:484.83 (10.1%) stddev-sans-first:459.70 16:48:53 INFO - 2015-11-20 16:48:53,868 DEBUG : BROWSER_OUTPUT: Values: 2674.3 2731.9 2742.1 2749.9 2756.4 4542.8 4764.9 4767.9 4792.9 4810.2 4621.9 4641.4 4699.4 4753.3 4778.8 4349.5 4349.6 4386.9 4407.1 4445.2 4463.0 4492.3 4510.6 4515.5 4521.6 4182.7 4228.0 4263.7 4369.5 4441.4 4396.6 4406.2 4416.1 4417.3 4448.3 4397.5 4403.6 4410.9 4433.6 4449.0 4488.3 4571.6 4611.3 4712.6 4714.8 5099.2 5131.2 5150.7 5153.0 5198.6 4892.6 5148.8 5150.4 5169.2 5182.6 4647.8 4678.0 4715.2 4718.3 4754.7 5206.2 5225.9 5254.1 5263.9 5291.7 4774.4 4857.6 4998.2 5003.3 5028.8 4996.2 5007.0 5100.0 5105.6 5154.8 5079.1 5079.5 5092.2 5096.2 5134.8 4770.2 4874.4 5061.8 5084.7 5089.0 4183.5 4255.4 4260.4 4301.4 4303.4 3764.4 3773.1 3773.7 3800.4 3815.8 4204.7 4292.5 4336.2 4430.8 4461.9 5108.5 5120.8 5147.2 5151.8 5158.6 4450.2 4454.6 4461.0 4461.2 4494.0 4330.4 4446.6 4469.0 4558.2 4651.2 4840.0 4842.7 4844.0 4844.2 4859.8 5060.7 5069.6 5072.3 5094.4 5125.4 4649.7 4767.9 4783.5 4854.5 4897.4 5023.7 5088.5 5110.0 5110.9 5148.7 4882.6 5123.6 5180.9 5181.8 5190.7 4843.8 4856.4 4915.6 4929.0 4950.0 4894.4 4908.0 4909.1 4943.4 4957.9 4568.3 4707.4 4796.5 4832.6 4874.4 4875.9 4933.7 4951.5 4953.3 4956.7 4832.3 4864.2 4895.9 4901.9 4940.0 16:48:53 INFO - 2015-11-20 16:48:53,868 DEBUG : BROWSER_OUTPUT: 16:48:53 INFO - 2015-11-20 16:48:53,868 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44189.70 Median:37880.93 stddev:73526.42 (194.1%) stddev-sans-first:73659.61 16:48:53 INFO - 2015-11-20 16:48:53,869 DEBUG : BROWSER_OUTPUT: Values: 532.9 563.1 567.0 567.7 588.4 28059.6 37453.0 37711.2 37893.2 37997.8 40350.6 40896.2 40989.2 41067.8 41136.4 7936.9 8097.5 8101.0 8102.0 8113.6 7945.2 7991.0 8028.9 8039.4 8044.2 7986.4 8039.4 8062.5 8066.2 8071.1 7960.6 8030.9 8035.6 8043.7 8075.5 7932.2 7976.6 7986.4 8028.3 8050.2 37797.0 37868.6 37949.8 38441.0 38484.0 2924.5 3005.7 3170.5 3339.2 3461.7 27783.9 27851.2 28265.4 28284.9 28673.0 3360.3 3371.6 3415.5 3464.8 3563.4 228685.0 231305.0 231365.0 231435.8 231780.0 52875.7 53984.2 56759.0 62789.7 63866.0 57412.0 57853.4 57969.4 58142.7 58150.0 12251.4 12412.6 12428.3 12435.6 12487.1 8954.6 9103.6 9176.4 9198.3 9202.7 19129.8 19578.4 19620.0 19645.6 19765.8 7825.8 8029.4 8037.4 8143.3 8165.3 825.3 833.9 866.8 946.9 976.4 30302.7 30329.8 30760.8 31302.5 31501.8 906.6 921.5 922.5 931.7 938.7 13289.7 13431.1 13460.5 15283.4 16129.0 337035.0 343152.0 343231.0 345056.0 346919.0 48448.5 48792.8 48841.5 48978.3 49020.8 1180.7 1197.7 1200.8 1202.7 1209.8 27302.7 28149.4 28184.6 29675.4 29920.6 41726.4 42941.4 43045.6 43073.8 43074.8 252397.0 254636.0 256427.0 257476.0 257841.0 39173.6 39175.0 39350.2 39350.8 40017.8 36097.5 38075.0 38306.2 40658.8 41478.4 33775.5 34175.0 34421.0 34436.3 34550.3 33704.3 34601.7 34652.5 34733.5 34890.7 34073.8 34411.8 34637.7 34854.3 34899.0 30353.2 30686.4 31623.5 31692.5 31777.0 24122.0 24305.0 24350.9 24468.4 24508.3 16:48:53 INFO - 2015-11-20 16:48:53,869 DEBUG : BROWSER_OUTPUT: 16:48:53 INFO - 2015-11-20 16:48:53,869 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25514.57 Median:464.79 stddev:80695.66 (17361.6%) stddev-sans-first:80899.89 16:48:53 INFO - 2015-11-20 16:48:53,869 DEBUG : BROWSER_OUTPUT: Values: 342.8 343.2 345.0 347.0 348.3 15008.5 15062.0 15659.6 15899.3 16395.8 10154.7 10331.8 13481.3 14882.9 14969.6 4471.1 4589.8 4597.7 5034.9 5208.2 5146.0 5179.0 5185.1 5186.0 5193.4 4905.7 5071.0 5096.8 5138.8 5253.9 5039.5 5084.6 5088.8 5093.6 5111.2 5019.4 5024.8 5025.0 5040.6 5053.5 11280.0 11282.5 11456.1 11458.6 11515.9 1825.3 1840.0 1865.0 1904.7 1957.9 8979.8 9121.7 9392.0 9401.2 10724.5 1603.5 1686.5 1712.9 1736.7 1750.5 54010.0 55831.2 56007.7 56392.4 56735.4 9422.6 9679.9 9801.1 9820.7 9882.5 12338.3 12399.1 12412.0 12434.2 12461.9 6632.6 6682.9 6714.5 6742.7 6749.1 6073.7 6159.8 6164.4 6264.0 6292.0 3961.3 4083.3 4141.1 4146.9 4168.0 1742.8 1757.7 1773.0 1779.0 1806.8 412.6 800.7 807.0 898.6 915.1 9400.4 9609.9 9798.3 9845.8 9863.3 409.3 420.3 426.9 427.4 435.3 5349.0 5409.7 5454.5 5504.4 5541.1 478919.0 487199.0 495322.0 502784.0 503397.0 68501.6 68746.0 69624.0 69808.7 69846.3 463.4 466.2 467.6 468.2 469.4 9339.5 9411.5 9659.0 9668.7 9697.0 29204.9 29429.4 30168.7 30189.2 31403.0 38295.0 41364.6 41624.4 42024.6 45076.0 8706.7 8708.9 8725.3 8803.1 8888.7 10400.8 10432.8 10474.9 10522.1 10595.8 13287.9 13432.8 13454.9 13693.2 13824.8 13264.8 13373.3 13413.5 13564.2 13675.2 13791.6 13805.5 14073.9 14094.1 14403.4 8754.4 8794.2 8895.8 8901.4 8908.5 12724.6 12732.8 13486.0 13738.5 14137.3 16:48:53 INFO - 2015-11-20 16:48:53,869 DEBUG : BROWSER_OUTPUT: 16:48:53 INFO - 2015-11-20 16:48:53,869 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4637.98 Median:5907.60 stddev:2296.95 (38.9%) stddev-sans-first:2291.20 16:48:53 INFO - 2015-11-20 16:48:53,870 DEBUG : BROWSER_OUTPUT: Values: 1488.9 1590.4 1665.9 1673.8 1703.5 5510.5 5614.3 6276.5 6751.9 6767.8 6370.0 6409.1 6439.5 6475.9 6498.7 1982.9 2025.7 2028.0 2028.2 2033.6 2015.8 2024.6 2029.3 2070.6 2074.7 2022.8 2046.4 2069.9 2072.3 2072.3 2037.7 2056.3 2060.0 2060.8 2062.0 2030.2 2037.8 2068.6 2071.6 2080.9 6542.8 6622.5 6631.2 6631.9 6635.4 3992.5 4025.0 4039.9 4040.1 4041.0 2675.9 2684.2 2695.5 2744.8 2752.1 838.5 846.4 852.4 868.5 874.9 8387.2 8459.9 8486.2 8514.6 8558.1 3766.9 3778.8 3803.3 3804.8 3841.1 7547.8 7635.1 7636.0 7638.7 7648.9 3961.6 3966.6 3970.7 3984.8 3986.2 3575.1 3590.8 3597.6 3725.6 3741.9 3194.2 3201.2 3220.8 3232.0 3236.6 953.2 956.5 961.9 988.6 989.4 858.2 891.2 1150.4 1151.4 1167.6 6209.8 6214.5 6255.7 6287.8 6314.5 1025.5 1025.6 1042.9 1059.6 1086.2 5022.7 5026.3 5040.1 5065.7 5080.9 7609.2 7662.0 7705.0 7928.4 7969.7 7786.5 7802.6 7869.7 7877.5 7877.8 6126.4 6217.7 6246.9 6250.0 6251.8 5908.4 5937.5 5942.0 5952.2 5959.8 6868.1 6993.1 7046.4 7133.8 7167.7 7119.5 7228.3 7231.1 7281.6 7308.9 5315.0 5382.3 5396.3 5967.9 6181.6 6064.2 6143.8 6158.2 6165.8 6194.9 5905.8 6040.6 6062.5 6154.7 6178.3 5906.8 5966.4 6052.8 6074.8 6150.4 5900.5 5957.3 6019.8 6041.0 6064.7 5517.4 5524.9 5532.3 5534.1 5545.0 5391.5 5755.8 5774.7 5785.6 5813.4 16:48:53 INFO - 2015-11-20 16:48:53,870 DEBUG : BROWSER_OUTPUT: 16:48:53 INFO - 2015-11-20 16:48:53,870 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4880.66 Median:5461.33 stddev:1442.58 (26.4%) stddev-sans-first:1405.18 16:48:53 INFO - 2015-11-20 16:48:53,870 DEBUG : BROWSER_OUTPUT: Values: 306.6 315.4 317.4 318.3 320.4 5486.5 5604.4 5613.7 5670.6 5677.7 5360.4 5506.3 5546.6 5546.9 5559.9 4326.3 4334.7 4378.7 4393.3 4398.7 4376.5 4377.5 4384.6 4399.3 4399.9 4176.5 4251.9 4341.5 4349.4 4364.6 4277.1 4296.2 4302.9 4305.2 4307.7 3749.9 3751.8 3752.1 3756.9 3758.6 5412.6 5420.7 5427.2 5430.3 5436.1 4829.5 4871.3 4953.4 4953.8 4964.3 5733.5 5859.2 5872.2 5873.2 5880.6 4062.9 4064.4 4072.0 4075.3 4084.5 6114.8 6171.8 6203.8 6205.5 6210.3 4076.1 4162.8 4169.5 4187.4 4193.3 4249.1 4250.7 4256.3 4258.9 4274.7 4884.3 4889.8 4897.2 4902.1 4912.5 5812.3 5844.4 5867.1 5875.3 5885.2 1466.6 1492.1 1512.3 1514.7 1516.6 1009.1 1012.4 1013.0 1016.6 1021.7 5100.9 5121.5 5123.1 5132.2 5133.7 6071.3 6091.1 6095.1 6096.1 6096.9 5085.6 5098.1 5120.1 5121.2 5124.2 3224.6 3270.6 3299.0 3301.6 3301.8 5733.1 5742.3 5750.1 5753.9 5759.0 6246.7 6273.2 6276.7 6280.9 6292.9 5719.1 5730.5 5731.6 5833.1 5850.4 6110.4 6126.3 6151.7 6192.1 6217.0 5990.1 6007.4 6018.8 6031.8 6035.3 5686.8 5812.5 5813.8 5827.5 5834.5 4108.6 4182.8 4188.6 4191.5 4203.1 6124.2 6140.4 6152.7 6155.0 6156.4 5874.7 5893.4 5900.2 5917.3 5917.9 5748.3 5910.3 5921.2 5940.1 5953.4 5780.8 5809.1 5809.2 5810.3 5823.0 5942.2 5951.3 5981.7 5984.8 5997.0 5690.5 5768.1 5815.3 5830.7 5837.0 16:48:53 INFO - 2015-11-20 16:48:53,870 DEBUG : BROWSER_OUTPUT: 16:48:53 INFO - 2015-11-20 16:48:53,871 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12994.19 Median:22672.39 stddev:15065.02 (66.4%) stddev-sans-first:15078.96 16:48:53 INFO - 2015-11-20 16:48:53,871 DEBUG : BROWSER_OUTPUT: Values: 693.8 710.9 800.2 802.2 818.9 11802.9 12199.6 12214.9 12251.9 12256.4 13643.5 13714.5 13914.7 13970.4 13978.4 772.7 793.1 796.1 808.4 809.1 801.8 809.2 813.6 814.9 817.9 836.4 842.7 843.1 844.1 845.1 822.8 823.7 828.6 829.4 836.6 611.3 614.8 617.2 618.3 620.5 11731.9 11741.3 11877.1 11882.9 11884.8 10736.7 11148.7 11318.2 11597.2 12011.4 9526.8 9676.8 9795.9 9871.7 10749.4 3219.1 3255.5 3268.3 3272.8 3371.0 42300.0 43506.3 43546.6 43769.0 43818.6 9121.7 9141.8 9467.2 9576.4 9690.7 16659.0 17201.8 17204.4 17249.7 17281.6 6409.9 6463.9 6644.5 6657.1 6816.5 3634.7 3699.3 3702.9 3706.6 3710.8 2637.0 2642.6 2650.6 2667.7 2679.3 470.1 477.7 481.4 508.0 524.3 456.8 492.2 533.5 563.9 621.8 7486.6 7651.3 8410.0 8742.0 8907.9 585.2 605.8 611.5 620.6 645.2 3752.3 3850.9 3936.7 4012.4 4012.5 54927.7 55275.4 55710.0 55837.0 56218.7 47715.8 48098.6 48247.3 48826.5 48853.0 44244.3 44318.3 44762.8 44885.3 44888.0 7792.1 7816.5 8187.2 8363.5 8450.0 31183.8 31788.0 32251.4 33589.7 34453.7 41043.2 41241.4 41948.0 42281.2 42524.0 10226.8 10345.9 10356.6 10379.0 10643.5 11105.5 11296.4 11404.9 11803.9 11837.8 11024.6 11118.3 11206.6 11309.2 11386.8 11011.8 11088.6 11186.7 11246.9 11313.3 10404.8 10616.3 10772.7 10818.4 10858.3 9218.7 9310.2 9322.3 9536.3 9571.2 7944.6 8643.9 8686.5 8838.8 8994.9 16:48:53 INFO - 2015-11-20 16:48:53,871 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:48:53 INFO - 2015-11-20 16:48:53,871 DEBUG : BROWSER_OUTPUT: 16:48:54 INFO - 2015-11-20 16:48:54,570 INFO : Browser exited with error code: 0 16:48:54 INFO - 2015-11-20 16:48:54,593 INFO : Completed test dromaeo_css (00:18:34) 16:48:54 INFO - 2015-11-20 16:48:54,593 INFO : Starting test kraken 16:48:54 INFO - 2015-11-20 16:48:54,593 DEBUG : operating with platform_type : linux_ 16:48:54 INFO - 2015-11-20 16:48:54,593 INFO : Initialising browser for kraken test... 16:48:54 INFO - 2015-11-20 16:48:54,599 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYK6ZO0/profile http://localhost:35609/getInfo.html 16:48:59 INFO - 2015-11-20 16:48:59,827 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:48:59 INFO - 2015-11-20 16:48:59,827 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:48:59 INFO - 2015-11-20 16:48:59,828 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:48:59 INFO - 2015-11-20 16:48:59,828 DEBUG : BROWSER_OUTPUT: __metrics 16:49:00 INFO - 2015-11-20 16:49:00,873 INFO : Browser initialized. 16:49:00 INFO - 2015-11-20 16:49:00,874 INFO : Running cycle 1/1 for kraken test... 16:49:00 INFO - 2015-11-20 16:49:00,874 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYK6ZO0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:49:12 INFO - 2015-11-20 16:49:12,827 DEBUG : BROWSER_OUTPUT: RSS: Main: 141791232 16:49:12 INFO - 2015-11-20 16:49:12,827 DEBUG : BROWSER_OUTPUT: 16:49:15 INFO - 2015-11-20 16:49:15,423 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35609/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35609/tests/kraken/driver.html?testName=audio-beat-detection) 16:49:16 INFO - 2015-11-20 16:49:16,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 141090816 16:49:16 INFO - 2015-11-20 16:49:16,037 DEBUG : BROWSER_OUTPUT: 16:49:18 INFO - 2015-11-20 16:49:18,766 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35609/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35609/tests/kraken/driver.html?testName=audio-dft) 16:49:19 INFO - 2015-11-20 16:49:19,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 141619200 16:49:19 INFO - 2015-11-20 16:49:19,367 DEBUG : BROWSER_OUTPUT: 16:49:22 INFO - 2015-11-20 16:49:22,273 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35609/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35609/tests/kraken/driver.html?testName=audio-fft) 16:49:22 INFO - 2015-11-20 16:49:22,858 DEBUG : BROWSER_OUTPUT: RSS: Main: 137756672 16:49:22 INFO - 2015-11-20 16:49:22,858 DEBUG : BROWSER_OUTPUT: 16:49:24 INFO - 2015-11-20 16:49:24,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35609/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35609/tests/kraken/driver.html?testName=audio-oscillator) 16:49:25 INFO - 2015-11-20 16:49:25,544 DEBUG : BROWSER_OUTPUT: RSS: Main: 138129408 16:49:25 INFO - 2015-11-20 16:49:25,545 DEBUG : BROWSER_OUTPUT: 16:49:27 INFO - 2015-11-20 16:49:27,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35609/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35609/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:49:28 INFO - 2015-11-20 16:49:28,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 138747904 16:49:28 INFO - 2015-11-20 16:49:28,365 DEBUG : BROWSER_OUTPUT: 16:49:31 INFO - 2015-11-20 16:49:31,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35609/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35609/tests/kraken/driver.html?testName=imaging-darkroom) 16:49:32 INFO - 2015-11-20 16:49:32,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 137859072 16:49:32 INFO - 2015-11-20 16:49:32,030 DEBUG : BROWSER_OUTPUT: 16:49:35 INFO - 2015-11-20 16:49:35,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35609/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35609/tests/kraken/driver.html?testName=imaging-desaturate) 16:49:36 INFO - 2015-11-20 16:49:36,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 136790016 16:49:36 INFO - 2015-11-20 16:49:36,120 DEBUG : BROWSER_OUTPUT: 16:49:39 INFO - 2015-11-20 16:49:39,018 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35609/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35609/tests/kraken/driver.html?testName=json-parse-financial) 16:49:39 INFO - 2015-11-20 16:49:39,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 137715712 16:49:39 INFO - 2015-11-20 16:49:39,611 DEBUG : BROWSER_OUTPUT: 16:49:41 INFO - 2015-11-20 16:49:41,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35609/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35609/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:49:41 INFO - 2015-11-20 16:49:41,962 DEBUG : BROWSER_OUTPUT: RSS: Main: 139182080 16:49:41 INFO - 2015-11-20 16:49:41,962 DEBUG : BROWSER_OUTPUT: 16:49:43 INFO - 2015-11-20 16:49:43,858 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35609/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35609/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:49:44 INFO - 2015-11-20 16:49:44,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 139206656 16:49:44 INFO - 2015-11-20 16:49:44,471 DEBUG : BROWSER_OUTPUT: 16:49:46 INFO - 2015-11-20 16:49:46,623 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35609/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35609/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:49:47 INFO - 2015-11-20 16:49:47,225 DEBUG : BROWSER_OUTPUT: RSS: Main: 139120640 16:49:47 INFO - 2015-11-20 16:49:47,225 DEBUG : BROWSER_OUTPUT: 16:49:49 INFO - 2015-11-20 16:49:49,801 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35609/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35609/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:49:50 INFO - 2015-11-20 16:49:50,407 DEBUG : BROWSER_OUTPUT: RSS: Main: 139722752 16:49:50 INFO - 2015-11-20 16:49:50,407 DEBUG : BROWSER_OUTPUT: 16:49:53 INFO - 2015-11-20 16:49:53,042 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35609/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35609/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:49:53 INFO - 2015-11-20 16:49:53,637 DEBUG : BROWSER_OUTPUT: RSS: Main: 139026432 16:49:53 INFO - 2015-11-20 16:49:53,637 DEBUG : BROWSER_OUTPUT: 16:49:55 INFO - 2015-11-20 16:49:55,398 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35609/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35609/tests/kraken/driver.html?testName=ai-astar) 16:49:55 INFO - 2015-11-20 16:49:55,649 DEBUG : BROWSER_OUTPUT: RSS: Main: 138358784 16:49:55 INFO - 2015-11-20 16:49:55,649 DEBUG : BROWSER_OUTPUT: 16:49:55 INFO - 2015-11-20 16:49:55,653 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:49:55 INFO - 2015-11-20 16:49:55,653 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:49:55 INFO - 2015-11-20 16:49:55,653 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:49:55 INFO - 2015-11-20 16:49:55,653 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:49:55 INFO - 2015-11-20 16:49:55,653 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;106;113;110;112;123;112;112;112;113 16:49:55 INFO - 2015-11-20 16:49:55,653 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;130;153;165;138;156;154;136;167;133 16:49:55 INFO - 2015-11-20 16:49:55,653 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;164;162;162;166;172;164;164;165 16:49:55 INFO - 2015-11-20 16:49:55,653 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;73;73;74;140;72;73;74;73 16:49:55 INFO - 2015-11-20 16:49:55,653 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;91;135;91;91;90;124;93;93;133 16:49:55 INFO - 2015-11-20 16:49:55,654 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;109;110;110;110;110;109;109;109 16:49:55 INFO - 2015-11-20 16:49:55,654 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;149;149;150;148;153;149;148;147 16:49:55 INFO - 2015-11-20 16:49:55,654 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;96;96;96;96;96;95;97 16:49:55 INFO - 2015-11-20 16:49:55,654 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;72;73;72;72;74;73;72;72;71 16:49:55 INFO - 2015-11-20 16:49:55,654 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;68;69;68;69;76;69 16:49:55 INFO - 2015-11-20 16:49:55,654 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;84;94;84;87;83;85;82;85;84 16:49:55 INFO - 2015-11-20 16:49:55,654 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;124;140;136;122;129;132;129;126;122 16:49:55 INFO - 2015-11-20 16:49:55,654 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;153;146;150;153;156;137;160;149;145;150 16:49:55 INFO - 2015-11-20 16:49:55,654 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;71;69;71;70;70;70;70;70 16:49:55 INFO - 2015-11-20 16:49:55,654 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:49:55 INFO - 2015-11-20 16:49:55,654 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:49:55 INFO - 2015-11-20 16:49:55,654 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,789 16:49:55 INFO - 2015-11-20 16:49:55,654 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:49:55 INFO - 2015-11-20 16:49:55,654 DEBUG : BROWSER_OUTPUT: __startTimestamp1448066995652__endTimestamp 16:49:55 INFO - 2015-11-20 16:49:55,654 DEBUG : BROWSER_OUTPUT: 16:49:55 INFO - 2015-11-20 16:49:55,658 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:49:55 INFO - 2015-11-20 16:49:55,658 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:49:55 INFO - 2015-11-20 16:49:55,658 DEBUG : BROWSER_OUTPUT: 16:49:55 INFO - 2015-11-20 16:49:55,658 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.70 Median:112.50 stddev:4.24 (3.8%) stddev-sans-first:4.48 16:49:55 INFO - 2015-11-20 16:49:55,658 DEBUG : BROWSER_OUTPUT: Values: 114.0 106.0 113.0 110.0 112.0 123.0 112.0 112.0 112.0 113.0 16:49:55 INFO - 2015-11-20 16:49:55,658 DEBUG : BROWSER_OUTPUT: 16:49:55 INFO - 2015-11-20 16:49:55,658 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.70 Median:154.50 stddev:13.38 (8.7%) stddev-sans-first:14.00 16:49:55 INFO - 2015-11-20 16:49:55,658 DEBUG : BROWSER_OUTPUT: Values: 155.0 130.0 153.0 165.0 138.0 156.0 154.0 136.0 167.0 133.0 16:49:55 INFO - 2015-11-20 16:49:55,658 DEBUG : BROWSER_OUTPUT: 16:49:55 INFO - 2015-11-20 16:49:55,658 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:2.99 (1.8%) stddev-sans-first:3.13 16:49:55 INFO - 2015-11-20 16:49:55,658 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 164.0 162.0 162.0 166.0 172.0 164.0 164.0 165.0 16:49:55 INFO - 2015-11-20 16:49:55,659 DEBUG : BROWSER_OUTPUT: 16:49:55 INFO - 2015-11-20 16:49:55,659 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.70 Median:73.00 stddev:21.20 (29.0%) stddev-sans-first:22.34 16:49:55 INFO - 2015-11-20 16:49:55,659 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 73.0 74.0 140.0 72.0 73.0 74.0 73.0 16:49:55 INFO - 2015-11-20 16:49:55,659 DEBUG : BROWSER_OUTPUT: 16:49:55 INFO - 2015-11-20 16:49:55,659 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.30 Median:91.00 stddev:19.11 (21.0%) stddev-sans-first:19.82 16:49:55 INFO - 2015-11-20 16:49:55,659 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 135.0 91.0 91.0 90.0 124.0 93.0 93.0 133.0 16:49:55 INFO - 2015-11-20 16:49:55,659 DEBUG : BROWSER_OUTPUT: 16:49:55 INFO - 2015-11-20 16:49:55,659 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 16:49:55 INFO - 2015-11-20 16:49:55,659 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 109.0 110.0 110.0 110.0 110.0 109.0 109.0 109.0 16:49:55 INFO - 2015-11-20 16:49:55,659 DEBUG : BROWSER_OUTPUT: 16:49:55 INFO - 2015-11-20 16:49:55,660 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:1.66 (1.1%) stddev-sans-first:1.73 16:49:55 INFO - 2015-11-20 16:49:55,660 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 149.0 149.0 150.0 148.0 153.0 149.0 148.0 147.0 16:49:55 INFO - 2015-11-20 16:49:55,660 DEBUG : BROWSER_OUTPUT: 16:49:55 INFO - 2015-11-20 16:49:55,660 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 16:49:55 INFO - 2015-11-20 16:49:55,660 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 95.0 97.0 16:49:55 INFO - 2015-11-20 16:49:55,660 DEBUG : BROWSER_OUTPUT: 16:49:55 INFO - 2015-11-20 16:49:55,660 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.40 Median:72.50 stddev:0.84 (1.2%) stddev-sans-first:0.87 16:49:55 INFO - 2015-11-20 16:49:55,660 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 72.0 72.0 74.0 73.0 72.0 72.0 71.0 16:49:55 INFO - 2015-11-20 16:49:55,660 DEBUG : BROWSER_OUTPUT: 16:49:55 INFO - 2015-11-20 16:49:55,660 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:2.44 (3.5%) stddev-sans-first:2.55 16:49:55 INFO - 2015-11-20 16:49:55,660 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 68.0 69.0 68.0 69.0 76.0 69.0 16:49:55 INFO - 2015-11-20 16:49:55,660 DEBUG : BROWSER_OUTPUT: 16:49:55 INFO - 2015-11-20 16:49:55,660 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.00 stddev:3.37 (4.0%) stddev-sans-first:3.54 16:49:55 INFO - 2015-11-20 16:49:55,660 DEBUG : BROWSER_OUTPUT: Values: 87.0 84.0 94.0 84.0 87.0 83.0 85.0 82.0 85.0 84.0 16:49:55 INFO - 2015-11-20 16:49:55,661 DEBUG : BROWSER_OUTPUT: 16:49:55 INFO - 2015-11-20 16:49:55,661 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:129.00 stddev:5.88 (4.6%) stddev-sans-first:6.23 16:49:55 INFO - 2015-11-20 16:49:55,661 DEBUG : BROWSER_OUTPUT: Values: 128.0 124.0 140.0 136.0 122.0 129.0 132.0 129.0 126.0 122.0 16:49:55 INFO - 2015-11-20 16:49:55,661 DEBUG : BROWSER_OUTPUT: 16:49:55 INFO - 2015-11-20 16:49:55,661 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.90 Median:151.50 stddev:6.37 (4.2%) stddev-sans-first:6.65 16:49:55 INFO - 2015-11-20 16:49:55,661 DEBUG : BROWSER_OUTPUT: Values: 153.0 146.0 150.0 153.0 156.0 137.0 160.0 149.0 145.0 150.0 16:49:55 INFO - 2015-11-20 16:49:55,661 DEBUG : BROWSER_OUTPUT: 16:49:55 INFO - 2015-11-20 16:49:55,661 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 16:49:55 INFO - 2015-11-20 16:49:55,661 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 71.0 69.0 71.0 70.0 70.0 70.0 70.0 70.0 16:49:55 INFO - 2015-11-20 16:49:55,661 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:49:55 INFO - 2015-11-20 16:49:55,661 DEBUG : BROWSER_OUTPUT: 16:49:56 INFO - 2015-11-20 16:49:56,617 INFO : Browser exited with error code: 0 16:49:56 INFO - 2015-11-20 16:49:56,666 INFO : Completed test kraken (00:01:02) 16:49:56 INFO - 2015-11-20 16:49:56,666 INFO : Starting test v8_7 16:49:56 INFO - 2015-11-20 16:49:56,666 DEBUG : operating with platform_type : linux_ 16:49:56 INFO - 2015-11-20 16:49:56,666 INFO : Initialising browser for v8_7 test... 16:49:56 INFO - 2015-11-20 16:49:56,672 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfAlx4h/profile http://localhost:35609/getInfo.html 16:50:01 INFO - 2015-11-20 16:50:01,842 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:50:01 INFO - 2015-11-20 16:50:01,842 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:50:01 INFO - 2015-11-20 16:50:01,842 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:50:01 INFO - 2015-11-20 16:50:01,843 DEBUG : BROWSER_OUTPUT: __metrics 16:50:03 INFO - 2015-11-20 16:50:03,013 INFO : Browser initialized. 16:50:03 INFO - 2015-11-20 16:50:03,014 INFO : Running cycle 1/1 for v8_7 test... 16:50:03 INFO - 2015-11-20 16:50:03,014 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfAlx4h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:50:14 INFO - 2015-11-20 16:50:14,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 141660160 16:50:14 INFO - 2015-11-20 16:50:14,922 DEBUG : BROWSER_OUTPUT: 16:50:36 INFO - 2015-11-20 16:50:36,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35609/tests/v8_7/run.html (next: http://localhost:35609/tests/v8_7/run.html) 16:50:36 INFO - 2015-11-20 16:50:36,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 137818112 16:50:36 INFO - 2015-11-20 16:50:36,655 DEBUG : BROWSER_OUTPUT: 16:50:36 INFO - 2015-11-20 16:50:36,655 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:50:36 INFO - 2015-11-20 16:50:36,655 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:50:36 INFO - 2015-11-20 16:50:36,655 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:50:36 INFO - 2015-11-20 16:50:36,655 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:50:36 INFO - 2015-11-20 16:50:36,656 DEBUG : BROWSER_OUTPUT: |0;Richards;162.78691193228065 16:50:36 INFO - 2015-11-20 16:50:36,657 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;182.68176835951772 16:50:36 INFO - 2015-11-20 16:50:36,657 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.72027972027973 16:50:36 INFO - 2015-11-20 16:50:36,657 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 16:50:36 INFO - 2015-11-20 16:50:36,657 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1062.6992561105208 16:50:36 INFO - 2015-11-20 16:50:36,657 DEBUG : BROWSER_OUTPUT: |5;Earley;710.7320540156361 16:50:36 INFO - 2015-11-20 16:50:36,658 DEBUG : BROWSER_OUTPUT: |6;Boyer;11976.190476190477 16:50:36 INFO - 2015-11-20 16:50:36,658 DEBUG : BROWSER_OUTPUT: |7;RegExp;25400 16:50:36 INFO - 2015-11-20 16:50:36,658 DEBUG : BROWSER_OUTPUT: |8;Splay;607.90273556231 16:50:36 INFO - 2015-11-20 16:50:36,658 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 16:50:36 INFO - 2015-11-20 16:50:36,658 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:50:36 INFO - 2015-11-20 16:50:36,658 DEBUG : BROWSER_OUTPUT: __startTimestamp1448067036654__endTimestamp 16:50:36 INFO - 2015-11-20 16:50:36,658 DEBUG : BROWSER_OUTPUT: 16:50:36 INFO - 2015-11-20 16:50:36,658 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:50:36 INFO - 2015-11-20 16:50:36,658 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:50:36 INFO - 2015-11-20 16:50:36,658 DEBUG : BROWSER_OUTPUT: 16:50:36 INFO - 2015-11-20 16:50:36,658 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.79 Median:162.79 stddev:0.00 (0.0%) 16:50:36 INFO - 2015-11-20 16:50:36,659 DEBUG : BROWSER_OUTPUT: Values: 162.8 16:50:36 INFO - 2015-11-20 16:50:36,659 DEBUG : BROWSER_OUTPUT: 16:50:36 INFO - 2015-11-20 16:50:36,659 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:182.68 Median:182.68 stddev:0.00 (0.0%) 16:50:36 INFO - 2015-11-20 16:50:36,659 DEBUG : BROWSER_OUTPUT: Values: 182.7 16:50:36 INFO - 2015-11-20 16:50:36,659 DEBUG : BROWSER_OUTPUT: 16:50:36 INFO - 2015-11-20 16:50:36,659 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 16:50:36 INFO - 2015-11-20 16:50:36,659 DEBUG : BROWSER_OUTPUT: Values: 279.7 16:50:36 INFO - 2015-11-20 16:50:36,659 DEBUG : BROWSER_OUTPUT: 16:50:36 INFO - 2015-11-20 16:50:36,659 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 16:50:36 INFO - 2015-11-20 16:50:36,660 DEBUG : BROWSER_OUTPUT: Values: 5050.5 16:50:36 INFO - 2015-11-20 16:50:36,660 DEBUG : BROWSER_OUTPUT: 16:50:36 INFO - 2015-11-20 16:50:36,660 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1062.70 Median:1062.70 stddev:0.00 (0.0%) 16:50:36 INFO - 2015-11-20 16:50:36,660 DEBUG : BROWSER_OUTPUT: Values: 1062.7 16:50:36 INFO - 2015-11-20 16:50:36,660 DEBUG : BROWSER_OUTPUT: 16:50:36 INFO - 2015-11-20 16:50:36,661 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:710.73 Median:710.73 stddev:0.00 (0.0%) 16:50:36 INFO - 2015-11-20 16:50:36,661 DEBUG : BROWSER_OUTPUT: Values: 710.7 16:50:36 INFO - 2015-11-20 16:50:36,661 DEBUG : BROWSER_OUTPUT: 16:50:36 INFO - 2015-11-20 16:50:36,661 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11976.19 Median:11976.19 stddev:0.00 (0.0%) 16:50:36 INFO - 2015-11-20 16:50:36,661 DEBUG : BROWSER_OUTPUT: Values: 11976.2 16:50:36 INFO - 2015-11-20 16:50:36,661 DEBUG : BROWSER_OUTPUT: 16:50:36 INFO - 2015-11-20 16:50:36,661 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25400.00 Median:25400.00 stddev:0.00 (0.0%) 16:50:36 INFO - 2015-11-20 16:50:36,661 DEBUG : BROWSER_OUTPUT: Values: 25400.0 16:50:36 INFO - 2015-11-20 16:50:36,661 DEBUG : BROWSER_OUTPUT: 16:50:36 INFO - 2015-11-20 16:50:36,662 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:607.90 Median:607.90 stddev:0.00 (0.0%) 16:50:36 INFO - 2015-11-20 16:50:36,662 DEBUG : BROWSER_OUTPUT: Values: 607.9 16:50:36 INFO - 2015-11-20 16:50:36,662 DEBUG : BROWSER_OUTPUT: 16:50:36 INFO - 2015-11-20 16:50:36,662 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 16:50:36 INFO - 2015-11-20 16:50:36,662 DEBUG : BROWSER_OUTPUT: Values: 4830.9 16:50:36 INFO - 2015-11-20 16:50:36,662 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:50:36 INFO - 2015-11-20 16:50:36,662 DEBUG : BROWSER_OUTPUT: 16:50:37 INFO - 2015-11-20 16:50:37,609 INFO : Browser exited with error code: 0 16:50:37 INFO - 2015-11-20 16:50:37,621 INFO : Completed test v8_7 (00:00:40) 16:50:37 INFO - 2015-11-20 16:50:37,675 INFO : Completed test suite (00:20:17) 16:50:37 INFO - 2015-11-20 16:50:37,676 DEBUG : Working with test: dromaeo_css 16:50:37 INFO - 2015-11-20 16:50:37,676 DEBUG : Generating results file: dromaeo_css 16:50:37 INFO - 2015-11-20 16:50:37,677 DEBUG : Working with test: kraken 16:50:37 INFO - 2015-11-20 16:50:37,677 DEBUG : Generating results file: kraken 16:50:37 INFO - 2015-11-20 16:50:37,677 INFO : javascript benchmark 16:50:37 INFO - 2015-11-20 16:50:37,677 DEBUG : Working with test: v8_7 16:50:37 INFO - 2015-11-20 16:50:37,678 DEBUG : Generating results file: v8_7 16:50:37 INFO - 2015-11-20 16:50:37,678 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:50:37 INFO - 2015-11-20 16:50:37,728 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 16:50:37 INFO - 2015-11-20 16:50:37,728 DEBUG : process_Request line: dromaeo_css 6264.57 graph.html#tests=[[72,132,43]] 16:50:37 INFO - 2015-11-20 16:50:37,728 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:50:37 INFO - 2015-11-20 16:50:37,761 DEBUG : process_Request line: kraken 1539.20 graph.html#tests=[[232,132,43]] 16:50:37 INFO - 2015-11-20 16:50:37,761 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:50:37 INFO - 2015-11-20 16:50:37,869 DEBUG : process_Request line: v8_7 21587.12 graph.html#tests=[[230,132,43]] 16:50:37 INFO - 2015-11-20 16:50:37,871 INFO : javascript benchmark 16:50:37 INFO - 2015-11-20 16:50:37,874 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2674.251209661295, 2731.931701707458, 2742.0676969830256, 2749.862506874657, 2756.4349308391784, 4542.750148741818, 4764.928526072107, 4767.928481072782, 4792.90414191716, 4810.182269014267, 4621.930671039937, 4641.396618439599, 4699.365585645936, 4753.263244197146, 4778.80884764609, 4349.456317960255, 4349.630281426083, 4386.868393948171, 4407.07451435199, 4445.155420470101, 4463.018136010072, 4492.348609451627, 4510.594046535811, 4515.525869783674, 4521.638268938477, 4182.686298527623, 4228.048689044971, 4263.658907287409, 4369.453818272716, 4441.356003379508, 4396.582324679182, 4406.228909940747, 4416.072624748806, 4417.315316126005, 4448.266036104039, 4397.494288156871, 4403.603675669206, 4410.889727756799, 4433.6009759121835, 4448.955510444886, 4488.326750987346, 4571.58855702985, 4611.30830375443, 4712.6229901607785, 4714.787834547454, 5099.15863882459, 5131.153359695646, 5150.68657492337, 5153.0, 5198.584113270929, 4892.608591312722, 5148.819791307324, 5150.4334523202415, 5169.172932330809, 5182.559482443997, 4647.814087436533, 4678.0, 4715.174844402216, 4718.339432479455, 4754.7147171169845, 5206.193040078794, 5225.947740522546, 5254.133068043807, 5263.868403289948, 5291.656042357235, 4774.427068751703, 4857.635677324144, 4998.150314446553, 5003.3495645565845, 5028.7737051832755, 4996.15065438869, 5006.974965125151, 5100.030994111107, 5105.591552675852, 5154.819581314636, 5079.085764562415, 5079.517445842639, 5092.236164575269, 5096.210087436453, 5134.768935397916, 4770.189067858472, 4874.390701162355, 5061.822836200715, 5084.720340381315, 5089.00764350948, 4183.477065366829, 4255.4255175551525, 4260.403543503912, 4301.41930839339, 4303.440552728125, 3764.3600587900123, 3773.0755964788805, 3773.716971227169, 3800.3539398302355, 3815.790131542736, 4204.726692764961, 4292.463442069741, 4336.154449882306, 4430.756308403069, 4461.910761784746, 5108.540231379119, 5120.769565369567, 5147.176451767699, 5151.845444636667, 5158.587313014949, 4450.221211288076, 4454.643628509712, 4461.04087621163, 4461.196984542814, 4494.0, 4330.350447432847, 4446.644268458515, 4468.977655111768, 4558.247889098262, 4651.232546629836, 4839.975800120977, 4842.661013729075, 4843.951560484421, 4844.224924012141, 4859.781309841136, 5060.746962651926, 5069.645124841226, 5072.28987941681, 5094.363204599425, 5125.410577783603, 4649.744264065509, 4767.904641907212, 4783.521647835189, 4854.466008738966, 4897.363342765418, 5023.723695196799, 5088.542031217208, 5110.0, 5110.9488905110475, 5148.742562871917, 4882.584980276574, 5123.590112790893, 5180.896382072413, 5181.81863634771, 5190.6626069306885, 4843.782029808737, 4856.441509226484, 4915.557599816034, 4928.975355123202, 4950.034743225036, 4894.388201474816, 4908.042931628298, 4909.140900342497, 4943.431505376784, 4957.900841983213, 4568.291914753218, 4707.411573553306, 4796.544328288807, 4832.613390928787, 4874.390701162355, 4875.926861097016, 4933.654644174873, 4951.455339912679, 4953.3065370848835, 4956.677815941952, 4832.323474713473, 4864.246041863516, 4895.877603059952, 4901.9264711028645, 4939.98730260303], "unit": "ms", "name": "dojo.html", "value": 4664.382977198421}, {"lowerIsBetter": false, "replicates": [532.9014132385508, 563.0625009359417, 566.9546436285099, 567.7445149682644, 588.4204059001885, 28059.57910631342, 37453.0, 37711.245775084484, 37893.24213515728, 37997.81001094998, 40350.59649403505, 40896.18207635853, 40989.18021639565, 41067.794661026724, 41136.38295425571, 7936.920630793705, 8097.473664211808, 8101.0, 8101.95949020257, 8113.594320283992, 7945.205479452037, 7990.960045199795, 8028.879566806473, 8039.356851451899, 8044.155363686817, 7986.440949133563, 8039.356851451899, 8062.475939063971, 8066.193380661945, 8071.112177660452, 7960.641771120314, 8030.919690803075, 8035.5580443075605, 8043.718469853527, 8075.475094118922, 7932.246436588515, 7976.601169941479, 7986.401019923529, 8028.317593004544, 8050.194980501961, 37797.0, 37868.62131378706, 37949.810250948845, 38441.03897402559, 38484.0, 2924.4882145624642, 3005.684403137661, 3170.4768713162302, 3339.1985923378456, 3461.6538346165435, 27783.86108069467, 27851.164465066082, 28265.434691306265, 28284.85857570699, 28673.0, 3360.2775403288165, 3371.561696979377, 3415.453527435623, 3464.7574669773126, 3563.4033690902534, 228685.0, 231305.0, 231365.0, 231435.8428207865, 231780.0, 52875.73562132242, 53984.190237146475, 56759.0, 62789.68605156945, 63866.0, 57412.0, 57853.42146578564, 57969.42030579725, 58142.7092864533, 58150.0, 12251.448684809027, 12412.62762117138, 12428.254304741744, 12435.626931192079, 12487.125901187012, 8954.597043132944, 9103.590338434786, 9176.403533770417, 9198.264138868875, 9202.723918282461, 19129.810496717073, 19578.412647620593, 19620.0, 19645.607087858447, 19765.802341976683, 7825.843483130306, 8029.397795165269, 8037.35701143907, 8143.307818835347, 8165.346772258205, 825.3026192867018, 833.8582440985047, 866.7616405488415, 946.8532377481501, 976.3556053004983, 30302.69697303043, 30329.848350758104, 30760.846195768878, 31302.530462043087, 31501.842490787858, 906.551257127726, 921.4517362169498, 922.4557511068501, 931.7158266728712, 938.6902322233647, 13289.734205316034, 13431.059825812295, 13460.528881489297, 15283.38866445352, 16129.0, 337035.0, 343152.0, 343231.0, 345056.0, 346919.0, 48448.5155148444, 48792.756036219595, 48841.51158488441, 48978.26532601943, 49020.754896226004, 1180.6753142885775, 1197.6586672798385, 1200.7778560966249, 1202.6572426858304, 1209.7761914046105, 27302.72697273002, 28149.43701126007, 28184.577231341136, 29675.406491870475, 29920.55119173258, 41726.37410438906, 42941.35587966246, 43045.56954430541, 43073.78463107665, 43074.78462607667, 252397.0, 254636.0, 256427.0, 257476.0, 257841.0, 39173.608263917, 39175.0, 39350.2129957405, 39350.80324598359, 40017.79991100142, 36097.458538122475, 38075.0, 38306.2338753229, 40658.79670601746, 41478.37782433326, 33775.4933676, 34175.0, 34421.0, 34436.278186090094, 34550.30899382049, 33704.3259134811, 34601.653983459844, 34652.48021279733, 34733.47899781455, 34890.65109348874, 34073.82963085169, 34411.82794086014, 34637.65362346344, 34854.30291394208, 34899.0, 30353.24116897095, 30686.386272274874, 31623.525647114853, 31692.524612130375, 31777.0, 24122.0, 24305.0, 24350.87824560866, 24468.388290292885, 24508.26475205747], "unit": "ms", "name": "ext.html", "value": 17432.88102052543}, {"lowerIsBetter": false, "replicates": [342.8080275045974, 343.159259813457, 345.03218472185523, 347.04735501049623, 348.3294657783766, 15008.549743507698, 15062.0, 15659.60850978726, 15899.28453219605, 16395.83604163958, 10154.74613134672, 10331.845022324671, 13481.3259337033, 14882.851171488282, 14969.550913472613, 4471.105778844228, 4589.839355622554, 4597.747123908183, 5034.899302013958, 5208.166693329068, 5145.974270128644, 5179.0, 5185.118529849935, 5186.0, 5193.376794784631, 4905.705657660552, 5071.036503064424, 5096.770645320969, 5138.768755406016, 5253.9474605253845, 5039.546440820307, 5084.618653600976, 5088.847334579968, 5093.567046801008, 5111.156659151254, 5019.3976722793495, 5024.79900803971, 5025.045241404122, 5040.6471546991725, 5053.545180933696, 11279.984801367917, 11282.492287846984, 11456.083513318914, 11458.598949036827, 11515.942420287929, 1825.3428765644358, 1839.9908000460046, 1865.020864046373, 1904.7238150468243, 1957.921683132673, 8979.820403591957, 9121.680741174094, 9392.0, 9401.24790016797, 10724.463776811128, 1603.5029140966337, 1686.502481767869, 1712.940047098358, 1736.6700326937842, 1750.5252074631846, 54010.0, 55831.16253256204, 56007.71996140034, 56392.436075639125, 56735.43264567343, 9422.575984080733, 9679.9032009679, 9801.11789938909, 9820.65627703027, 9882.4564648945, 12338.259704417764, 12399.13206075566, 12412.0, 12434.191777534432, 12461.93769031149, 6632.602043877287, 6682.933170668328, 6714.496412768965, 6742.696578653972, 6749.122614060141, 6073.665948372882, 6159.784407545714, 6164.445199931938, 6263.997760358321, 6292.0, 3961.3463778476803, 4083.305838007546, 4141.109661422748, 4146.937795933003, 4167.979160104241, 1742.7560141580188, 1757.7099778536399, 1772.955676108082, 1778.9644207116044, 1806.765120534322, 412.6100834711229, 800.6797281087612, 806.9596520173968, 898.6046139698511, 915.1260546178383, 9400.435973841591, 9609.90390096104, 9798.265130115127, 9845.80308393828, 9863.309568330147, 409.25924077419967, 420.31278859065645, 426.9146170765859, 427.4165763732483, 435.34697953070395, 5348.973255133699, 5409.675419474844, 5454.4545545445935, 5504.366997795225, 5541.0580201365865, 478919.0, 487199.0, 495322.0, 502784.0, 503397.0, 68501.57492125373, 68746.0, 69624.0, 69808.65095674591, 69846.30153698499, 463.39064130668066, 466.1981392005745, 467.632908167094, 468.1666633392567, 469.40854523300203, 9339.533023348942, 9411.52942352866, 9659.0, 9668.70993870157, 9697.0, 29204.853975729984, 29429.411411771216, 30168.69831301659, 30189.245268868453, 31403.0, 38295.0, 41364.586354136074, 41624.375634366115, 42024.57975420329, 45076.041635419424, 8706.695265665672, 8708.912910871064, 8725.25835303981, 8803.075677053817, 8888.688895888612, 10400.791984160123, 10432.791344173225, 10474.895251047392, 10522.053015228666, 10595.788084238426, 13287.933560332136, 13432.798508022192, 13454.865451345362, 13693.246871422167, 13824.792628110385, 13264.80102798478, 13373.331333433483, 13413.463461461432, 13564.186148831102, 13675.179489230679, 13791.586252412444, 13805.51680691171, 14073.929630351782, 14094.083884547472, 14403.351849166604, 8754.430961987451, 8794.164554367326, 8895.777605559913, 8901.376903616685, 8908.465492070496, 12724.554640587536, 12732.809007864704, 13486.0, 13738.450461981409, 14137.293135343398], "unit": "ms", "name": "jquery.html", "value": 7336.565929625673}, {"lowerIsBetter": false, "replicates": [1488.9354111810053, 1590.4194968836375, 1665.933362665493, 1673.7656728058073, 1703.454894433781, 5510.504054635082, 5614.27014488117, 6276.46650034747, 6751.932480675192, 6767.796966091019, 6370.044493326003, 6409.13476680648, 6439.517036222279, 6475.90286145707, 6498.675066246692, 1982.861199716017, 2025.6556385414515, 2028.0265472573174, 2028.2191356327846, 2033.5526184239518, 2015.768186658531, 2024.564718585504, 2029.2796057399632, 2070.596233734415, 2074.7406574178226, 2022.8078332558457, 2046.355398049617, 2069.9172033118657, 2072.316135675231, 2072.336852207294, 2037.74528183977, 2056.3008577083788, 2059.9588008239753, 2060.7527096748336, 2061.9793802061936, 2030.2082187946712, 2037.7962203779653, 2068.565601223745, 2071.616750901088, 2080.9479763005893, 6542.836429089263, 6622.470202383798, 6631.204255489372, 6631.867362652768, 6635.402813746786, 3992.480977472939, 4024.9597504024878, 4039.939400908989, 4040.0909795296116, 4041.009952561612, 2675.8929642814264, 2684.181324695967, 2695.5417579011614, 2744.794140439455, 2752.0642981386427, 838.5178522349673, 846.3525403066659, 852.40757673417, 868.4832524647887, 874.9212570868589, 8387.245147936716, 8459.873101903477, 8486.236238738482, 8514.574271286472, 8558.101399353041, 3766.8681596144, 3778.7732736035928, 3803.2963901678277, 3804.8097595120134, 3841.1357444574746, 7547.849043019219, 7635.121960974559, 7635.961820190863, 7638.732644357421, 7648.885266721004, 3961.5840336764227, 3966.5636779954184, 3970.7220494565104, 3984.780837053932, 3986.242613903349, 3575.0526110580718, 3590.784552926833, 3597.586277578112, 3725.590185079639, 3741.8503259869844, 3194.2493514024186, 3201.167696398953, 3220.806751594865, 3231.9838400807844, 3236.6116066072223, 953.2421724728857, 956.5408603870181, 961.9134277915022, 988.5946761827616, 989.3766926836047, 858.2018722587928, 891.157855826251, 1150.367297986121, 1151.37825574189, 1167.620523329921, 6209.751609935643, 6214.502839772807, 6255.687215639291, 6287.842803929939, 6314.526410519229, 1025.477006726575, 1025.5948900184385, 1042.9426381548935, 1059.6397224943555, 1086.21792309537, 5022.723750193702, 5026.346574945233, 5040.143175660147, 5065.696058236517, 5080.949190508121, 7609.239076092457, 7661.961690191625, 7705.036870391201, 7928.445008849325, 7969.681212751425, 7786.493877898032, 7802.570858602831, 7869.685212591547, 7877.487963282369, 7877.842443151105, 6126.448619624166, 6217.720202590895, 6246.906296405557, 6250.0, 6251.812445626548, 5908.438698323653, 5937.465628093492, 5942.0, 5952.226210592768, 5959.821205363846, 6868.107146070979, 6993.125859267591, 7046.401055910305, 7133.785986420416, 7167.749128780468, 7119.466040046914, 7228.349448549656, 7231.096112985877, 7281.5631062136445, 7308.926910730825, 5315.04329220744, 5382.30030096085, 5396.271503346998, 5967.850803729942, 6181.629102253879, 6064.241969753781, 6143.754249830135, 6158.230221222348, 6165.815025549241, 6194.907076393768, 5905.793297234748, 6040.607360521552, 6062.484688801501, 6154.661493617894, 6178.320384757583, 5906.763729450946, 5966.433188847052, 6052.848678783065, 6074.817755467343, 6150.384961503813, 5900.498457631149, 5957.255343082114, 6019.819405417845, 6041.033434650435, 6064.727087281171, 5517.36550296721, 5524.861878453071, 5532.253145825262, 5534.1145416733125, 5544.97227513876, 5391.541718953776, 5755.827325180251, 5774.740136693775, 5785.595008349375, 5813.447722466359], "unit": "ms", "name": "mootools.html", "value": 3876.107469728964}, {"lowerIsBetter": false, "replicates": [306.6488870243571, 315.3550988229071, 317.40169779964776, 318.25052002534034, 320.3656759615962, 5486.533644640201, 5604.439556044394, 5613.719314034302, 5670.574706896984, 5677.687727174998, 5360.410354860972, 5506.339239291291, 5546.556275497961, 5546.91679624805, 5559.8888022239535, 4326.329418940054, 4334.653227741789, 4378.71538350007, 4393.340998850166, 4398.714083584573, 4376.474823021226, 4377.518472967971, 4384.583464570861, 4399.274119770234, 4399.944013436768, 4176.519700234481, 4251.893702657428, 4341.522432532419, 4349.43457350544, 4364.607185353318, 4277.123189746095, 4296.2481565725875, 4302.913941721179, 4305.246581848164, 4307.719998200107, 3749.8687545936036, 3751.8499260029566, 3752.080740218664, 3756.868509602178, 3758.586555478895, 5412.621116521845, 5420.7018613976215, 5427.240186373911, 5430.348358197002, 5436.130219164954, 4829.517048295177, 4871.269309603553, 4953.43035550909, 4953.752312384402, 4964.255361695738, 5733.455321744427, 5859.150423188614, 5872.207252020965, 5873.207117039187, 5880.5883588148845, 4062.8984275393054, 4064.4106604542176, 4071.9592804071876, 4075.266452038632, 4084.5098588169312, 6114.816555503342, 6171.845703857394, 6203.751849925998, 6205.472534834499, 6210.347913469066, 4076.103257283393, 4162.83348666056, 4169.478815148106, 4187.413762073312, 4193.266178418765, 4249.086446414036, 4250.681198910094, 4256.297710877732, 4258.850940217078, 4274.700770946066, 4884.291777692215, 4889.779959901742, 4897.240927656219, 4902.093112774077, 4912.484189160086, 5812.331581868139, 5844.357120716718, 5867.090600956859, 5875.265591801025, 5885.234919460443, 1466.596685911383, 1492.060002198608, 1512.2589930933984, 1514.681916797485, 1516.5526169779941, 1009.0615727373466, 1012.427978192319, 1012.9971328384993, 1016.6340117557673, 1021.6526381030337, 5100.948990510122, 5121.4622464641425, 5123.052235336475, 5132.204508301219, 5133.743312834344, 6071.332153463116, 6091.14723938649, 6095.116208149882, 6096.055111457731, 6096.8780624388155, 5085.618578606619, 5098.056859481007, 5120.052790233819, 5121.231815227746, 5124.15451450514, 3224.596925384327, 3270.640229574745, 3298.983505082459, 3301.5542901707963, 3301.818399988024, 5733.111367738007, 5742.3396309424115, 5750.108733146369, 5753.913691294634, 5759.0, 6246.6876656167005, 6273.153124328157, 6276.717547710364, 6280.874382512324, 6292.874142517124, 5719.113537401709, 5730.5129064030025, 5731.598788084877, 5833.095870140135, 5850.414958504116, 6110.388961103854, 6126.264848218242, 6151.661658608819, 6192.133101365723, 6217.0, 5990.101484777319, 6007.369226231182, 6018.8194354169445, 6031.819045428644, 6035.305939816802, 5686.829395118153, 5812.505936995402, 5813.79651712188, 5827.533797296291, 5834.474897259267, 4108.609682080198, 4182.832686692498, 4188.602082802129, 4191.455110835572, 4203.054312779723, 6124.234470691164, 6140.4473597376455, 6152.723127459186, 6154.969225153845, 6156.445919867234, 5874.735636896265, 5893.351731309467, 5900.173975643327, 5917.289925209003, 5917.91123133162, 5748.310202775694, 5910.349861515316, 5921.171036055042, 5940.108983652487, 5953.434423729739, 5780.797672081457, 5809.070548712186, 5809.244798176379, 5810.273715785527, 5823.039198532195, 5942.1978032965, 5951.345352011189, 5981.700914954148, 5984.760609575568, 5996.970015149896, 5690.544756419559, 5768.134779783066, 5815.302163740378, 5830.708464576669, 5837.0], "unit": "ms", "name": "prototype.html", "value": 4414.8202836981945}, {"lowerIsBetter": false, "replicates": [693.8092024693209, 710.9040279562257, 800.1638287989052, 802.2458888644674, 818.9353840007988, 11802.940985295072, 12199.573014944479, 12214.877851221485, 12251.877481225185, 12256.387180640966, 13643.522476713317, 13714.519991800289, 13914.721705565908, 13970.37133329, 13978.3709733062, 772.7179579453515, 793.0879488588126, 796.0845028217539, 808.4300568099505, 809.1018968944467, 801.7835184500182, 809.2393150438598, 813.6460639621783, 814.8533264012475, 817.9263866252036, 836.4186890111375, 842.692417267699, 843.0684094076049, 844.0630899701326, 845.0577605969331, 822.8066404394963, 823.7199352220244, 828.5525816059321, 829.4318391901567, 836.6402446947841, 611.3153268339444, 614.7602435050334, 617.1883972576048, 618.2827919613227, 620.4663988969482, 11731.88268117325, 11741.29552226869, 11877.109216808687, 11882.88117118835, 11884.821727674092, 10736.73158171044, 11148.662160540705, 11318.158019397159, 11597.246178998423, 12011.399430028463, 9526.809463810754, 9676.806463870753, 9795.902040979641, 9871.703848884545, 10749.408782517037, 3219.0955874302067, 3255.5279484474618, 3268.346330733863, 3272.803631782077, 3371.0, 42300.0, 43506.347404788954, 43546.56453435457, 43769.0, 43818.56181438177, 9121.726348209564, 9141.81716365669, 9467.195288400562, 9576.425414475014, 9690.70927872165, 16659.0, 17201.827981720024, 17204.397846075328, 17249.741253881202, 17281.56796080108, 6409.935900641027, 6463.935360646427, 6644.534882558271, 6657.1345725055435, 6816.4546836252985, 3634.6910512606723, 3699.2601479704167, 3702.9259414811554, 3706.592274849764, 3710.8330125144435, 2636.973630263673, 2642.63003179555, 2650.628911952328, 2667.7465640764094, 2679.276595319253, 470.11148928525114, 477.672794136011, 481.39584821049357, 508.0220575392355, 524.3210042994332, 456.77617967195835, 492.17806263539256, 533.5224973648562, 563.8666280775589, 621.7699451202993, 7486.625668716542, 7651.3496352809525, 8409.957950210332, 8742.0, 8907.910920890838, 585.1982783586428, 605.7607245138146, 611.4955161991375, 620.5532016947881, 645.1935081148564, 3752.2683076799763, 3850.8844734658005, 3936.70088870672, 4012.378081397388, 4012.478377810866, 54927.72536137294, 55275.44724552703, 55710.0, 55837.0, 56218.71890640521, 47715.76142119337, 48098.5522274958, 48247.27629085567, 48826.51173488291, 48853.0, 44244.336334955, 44318.33522497165, 44762.77618611951, 44885.326720099874, 44888.0, 7792.10390805042, 7816.452848300564, 8187.181281871765, 8363.456375335583, 8449.95775021121, 31183.84408077945, 31788.0, 32251.35497290088, 33589.66410335866, 34453.65546344605, 41043.179136416504, 41241.381379279934, 41948.0, 42281.154376911676, 42524.0, 10226.795464090825, 10345.948270258601, 10356.585736570452, 10379.01399367059, 10643.521041552995, 11105.500252488497, 11296.4045089726, 11404.885951140383, 11803.940980295043, 11837.82243266369, 11024.559017639525, 11118.277311974696, 11206.607768728381, 11309.151813614177, 11386.772264554827, 11011.814071983223, 11088.556457741923, 11186.706660574802, 11246.943765281449, 11313.321200727984, 10404.843927341248, 10616.256862019585, 10772.676819695422, 10818.404987725751, 10858.34849909008, 9218.677346292847, 9310.162085412345, 9322.347435679438, 9536.284778641768, 9571.234301256021, 7944.602769861599, 8643.87034194475, 8686.52224127679, 8838.77903052403, 8994.910050899407], "unit": "ms", "name": "yui.html", "value": 5920.235636165437}], "name": "dromaeo_css", "value": 6264.573486965044}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 106.0, 113.0, 110.0, 112.0, 123.0, 112.0, 112.0, 112.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 112.7}, {"lowerIsBetter": true, "replicates": [155.0, 130.0, 153.0, 165.0, 138.0, 156.0, 154.0, 136.0, 167.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.7}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 164.0, 162.0, 162.0, 166.0, 172.0, 164.0, 164.0, 165.0], "unit": "ms", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 73.0, 74.0, 140.0, 72.0, 73.0, 74.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [92.0, 91.0, 135.0, 91.0, 91.0, 90.0, 124.0, 93.0, 93.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 103.3}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 149.0, 149.0, 150.0, 148.0, 153.0, 149.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 72.0, 72.0, 74.0, 73.0, 72.0, 72.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 72.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 68.0, 69.0, 68.0, 69.0, 76.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 94.0, 84.0, 87.0, 83.0, 85.0, 82.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [128.0, 124.0, 140.0, 136.0, 122.0, 129.0, 132.0, 129.0, 126.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 128.8}, {"lowerIsBetter": true, "replicates": [153.0, 146.0, 150.0, 153.0, 156.0, 137.0, 160.0, 149.0, 145.0, 150.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.9}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 71.0, 69.0, 71.0, 70.0, 70.0, 70.0, 70.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1539.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.78691193228065], "unit": "score", "name": "Richards", "value": 216.86018600000003}, {"lowerIsBetter": false, "replicates": [182.68176835951772], "unit": "score", "name": "DeltaBlue", "value": 361.929932}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5050.50505050505], "unit": "score", "name": "Decrypt", "value": 52.70383799999996}, {"lowerIsBetter": false, "replicates": [1062.6992561105208], "unit": "score", "name": "RayTrace", "value": 696.3296489999998}, {"lowerIsBetter": false, "replicates": [710.7320540156361], "unit": "score", "name": "Earley", "value": 937.7134409999999}, {"lowerIsBetter": false, "replicates": [11976.190476190477], "unit": "score", "name": "Boyer", "value": 55.648998011928406}, {"lowerIsBetter": false, "replicates": [25400.0], "unit": "score", "name": "RegExp", "value": 35.86555118110237}, {"lowerIsBetter": false, "replicates": [607.90273556231], "unit": "score", "name": "Splay", "value": 134.052695}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21587.117556894875}]} 16:50:37 INFO - RETURN: dromaeo_css: 6264.57 16:50:37 INFO - RETURN: kraken: 1539.20 16:50:37 INFO - RETURN: v8_7: 21587.12 16:50:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21587.12"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1539.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6264.57"}}} 16:50:37 INFO - Return code: 0 16:50:37 INFO - # TBPL SUCCESS # 16:50:37 INFO - Running post-action listener: _resource_record_post_action 16:50:37 INFO - Running post-run listener: _resource_record_post_run 16:50:39 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 8192; Write bytes: 498774016; Read time: 40; Write time: 355000 16:50:39 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 163147776; Read time: 0; Write time: 154520 16:50:39 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 269885440; Read time: 0; Write time: 140244 16:50:39 INFO - Running post-run listener: _upload_blobber_files 16:50:39 INFO - Blob upload gear active. 16:50:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:50:39 INFO - Copying logs to upload dir... 16:50:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1262.014488 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-20 16:50:38.849788) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:50:38.853246) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785 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.009845 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:50:38.904131) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:50:38.904481) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448065775.554887-71003785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:50:38.954658) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 16:50:38.954995) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 16:50:38.955295) ========= ========= Total master_lag: 0.21 =========