builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-024 starttime: 1447727146.41 results: success (0) buildid: 20151116173404 builduid: 899e92bb053f4ce5abfa77a691605bba revision: ffdc7f22130425020f5d648ef99c10b947541659 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 18:25:46.408715) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 18:25:46.409243) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 18:25:46.409598) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.003610 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 18:25:46.424943) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 18:25:46.425308) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 18:25:46.434782) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:25:46.435135) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003951 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:25:46.483297) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 18:25:46.483676) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 18:25:46.484153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:25:46.484475) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-16 18:25:46-- 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% 221M=0s 2015-11-16 18:25:46 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177595 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:25:46.676500) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:25:46.676872) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018638 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:25:46.727517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-16 18:25:46.727914) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ffdc7f22130425020f5d648ef99c10b947541659 --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 ffdc7f22130425020f5d648ef99c10b947541659 --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=5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-16 18:25:46,841 truncating revision to first 12 chars 2015-11-16 18:25:46,841 Setting DEBUG logging. 2015-11-16 18:25:46,841 attempt 1/10 2015-11-16 18:25:46,841 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ffdc7f221304?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 18:25:48,106 unpacking tar archive at: fx-team-ffdc7f221304/testing/mozharness/ program finished with exit code 0 elapsedTime=1.549800 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-16 18:25:48.291010) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 18:25:48.291393) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 18:25:48.300662) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 18:25:48.300965) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 18:25:48.301442) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-16 18:25:48.301764) ========= /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=5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:25:48 INFO - MultiFileLogger online at 20151116 18:25:48 in /builds/slave/test 18:25:48 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 18:25:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:25:48 INFO - {'append_to_log': False, 18:25:48 INFO - 'base_work_dir': '/builds/slave/test', 18:25:48 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:25:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:25:48 INFO - 'branch': 'Fx-Team-Non-PGO', 18:25:48 INFO - 'buildbot_json_path': 'buildprops.json', 18:25:48 INFO - 'config_files': ('talos/linux_config.py',), 18:25:48 INFO - 'default_actions': ('clobber', 18:25:48 INFO - 'read-buildbot-config', 18:25:48 INFO - 'download-and-extract', 18:25:48 INFO - 'populate-webroot', 18:25:48 INFO - 'create-virtualenv', 18:25:48 INFO - 'install', 18:25:48 INFO - 'run-tests'), 18:25:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:25:48 INFO - 'download_minidump_stackwalk': True, 18:25:48 INFO - 'download_symbols': 'ondemand', 18:25:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:25:48 INFO - 'tooltool.py': '/tools/tooltool.py', 18:25:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:25:48 INFO - '/tools/misc-python/virtualenv.py')}, 18:25:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:25:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:25:48 INFO - 'installer_path': 'installer.exe', 18:25:48 INFO - 'log_level': 'info', 18:25:48 INFO - 'log_name': 'talos', 18:25:48 INFO - 'log_to_console': True, 18:25:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:25:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:25:48 INFO - 'opt_config_files': (), 18:25:48 INFO - 'pip_index': False, 18:25:48 INFO - 'sps_profile': False, 18:25:48 INFO - 'sps_profile_interval': 0, 18:25:48 INFO - 'suite': 'dromaeojs-e10s', 18:25:48 INFO - 'system_bits': '64', 18:25:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:25:48 INFO - 'title': 'talos-linux64-ix-024', 18:25:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:25:48 INFO - 'use_talos_json': True, 18:25:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:25:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:25:48 INFO - 'work_dir': 'build'} 18:25:48 INFO - ##### 18:25:48 INFO - ##### Running clobber step. 18:25:48 INFO - ##### 18:25:48 INFO - Running pre-action listener: _resource_record_pre_action 18:25:48 INFO - Running main action method: clobber 18:25:48 INFO - rmtree: /builds/slave/test/build 18:25:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:25:48 INFO - Running post-action listener: _resource_record_post_action 18:25:48 INFO - ##### 18:25:48 INFO - ##### Running read-buildbot-config step. 18:25:48 INFO - ##### 18:25:48 INFO - Running pre-action listener: _resource_record_pre_action 18:25:48 INFO - Running main action method: read_buildbot_config 18:25:48 INFO - Using buildbot properties: 18:25:48 INFO - { 18:25:48 INFO - "properties": { 18:25:48 INFO - "buildnumber": 469, 18:25:48 INFO - "product": "firefox", 18:25:48 INFO - "script_repo_revision": "production", 18:25:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:25:48 INFO - "repository": "", 18:25:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 18:25:48 INFO - "buildid": "20151116173404", 18:25:48 INFO - "slavename": "talos-linux64-ix-024", 18:25:48 INFO - "pgo_build": "False", 18:25:48 INFO - "basedir": "/builds/slave/test", 18:25:48 INFO - "project": "", 18:25:48 INFO - "platform": "ubuntu64_hw", 18:25:48 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:25:48 INFO - "slavebuilddir": "test", 18:25:48 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:25:48 INFO - "branch": "fx-team", 18:25:48 INFO - "repo_path": "integration/fx-team", 18:25:48 INFO - "stage_platform": "linux64", 18:25:48 INFO - "builduid": "899e92bb053f4ce5abfa77a691605bba", 18:25:48 INFO - "revision": "ffdc7f22130425020f5d648ef99c10b947541659" 18:25:48 INFO - }, 18:25:48 INFO - "sourcestamp": { 18:25:48 INFO - "repository": "", 18:25:48 INFO - "hasPatch": false, 18:25:48 INFO - "project": "", 18:25:48 INFO - "branch": "fx-team-linux64-talos", 18:25:48 INFO - "changes": [ 18:25:48 INFO - { 18:25:48 INFO - "category": null, 18:25:48 INFO - "files": [ 18:25:48 INFO - { 18:25:48 INFO - "url": null, 18:25:48 INFO - "name": "https://queue.taskcluster.net/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:25:48 INFO - } 18:25:48 INFO - ], 18:25:48 INFO - "repository": "", 18:25:48 INFO - "rev": "ffdc7f22130425020f5d648ef99c10b947541659", 18:25:48 INFO - "who": "maglione.k@gmail.com", 18:25:48 INFO - "when": 1447726852, 18:25:48 INFO - "number": 6669554, 18:25:48 INFO - "comments": "Bug 1190321: [webext] Complete test coverage for the browserAction API. r=gabor", 18:25:48 INFO - "project": "", 18:25:48 INFO - "at": "Mon 16 Nov 2015 18:20:52", 18:25:48 INFO - "branch": "fx-team-linux64-talos", 18:25:48 INFO - "revlink": "", 18:25:48 INFO - "properties": [ 18:25:48 INFO - [ 18:25:48 INFO - "buildid", 18:25:48 INFO - "20151116173404", 18:25:48 INFO - "Change" 18:25:48 INFO - ], 18:25:48 INFO - [ 18:25:48 INFO - "builduid", 18:25:48 INFO - "899e92bb053f4ce5abfa77a691605bba", 18:25:48 INFO - "Change" 18:25:48 INFO - ], 18:25:48 INFO - [ 18:25:48 INFO - "pgo_build", 18:25:48 INFO - "False", 18:25:48 INFO - "Change" 18:25:48 INFO - ] 18:25:48 INFO - ], 18:25:48 INFO - "revision": "ffdc7f22130425020f5d648ef99c10b947541659" 18:25:48 INFO - } 18:25:48 INFO - ], 18:25:48 INFO - "revision": "ffdc7f22130425020f5d648ef99c10b947541659" 18:25:48 INFO - } 18:25:48 INFO - } 18:25:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:25:48 INFO - Running post-action listener: _resource_record_post_action 18:25:48 INFO - ##### 18:25:48 INFO - ##### Running download-and-extract step. 18:25:48 INFO - ##### 18:25:48 INFO - Running pre-action listener: _resource_record_pre_action 18:25:48 INFO - Running main action method: download_and_extract 18:25:48 INFO - mkdir: /builds/slave/test/build/tests 18:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:48 INFO - https://queue.taskcluster.net/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:25:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/test_packages.json 18:25:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/test_packages.json 18:25:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:25:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:25:49 INFO - Downloaded 1302 bytes. 18:25:49 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:25:49 INFO - Using the following test package requirements: 18:25:49 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:25:49 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:25:49 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:49 INFO - u'jsshell-linux-x86_64.zip'], 18:25:49 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:25:49 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:25:49 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:25:49 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:25:49 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:25:49 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:25:49 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:25:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:25:49 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')]} 18:25:49 INFO - https://queue.taskcluster.net/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:25:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:25:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:25:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2le5VeASl2xS9sFPc75KA/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 18:25:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2le5VeASl2xS9sFPc75KA/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 18:25:50 INFO - Downloaded 21274852 bytes. 18:25:50 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 18:25:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:25:50 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 18:25:51 INFO - Return code: 0 18:25:51 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 18:25:51 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')]} 18:25:51 INFO - https://queue.taskcluster.net/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:25:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:25:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:25:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2le5VeASl2xS9sFPc75KA/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 18:25:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2le5VeASl2xS9sFPc75KA/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 18:25:52 INFO - Downloaded 21274852 bytes. 18:25:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:25:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:25:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:25:53 INFO - Return code: 0 18:25:53 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')]} 18:25:53 INFO - https://queue.taskcluster.net/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:25:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:25:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:25:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2le5VeASl2xS9sFPc75KA/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 18:25:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2le5VeASl2xS9sFPc75KA/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 18:25:54 INFO - Downloaded 11131693 bytes. 18:25:54 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 18:25:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:25:54 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 18:25:55 INFO - Return code: 0 18:25: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')]} 18:25:55 INFO - https://queue.taskcluster.net/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:25:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:25:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:25:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2le5VeASl2xS9sFPc75KA/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 18:25:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2le5VeASl2xS9sFPc75KA/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 18:25:56 INFO - Downloaded 55618593 bytes. 18:25:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:25:56 INFO - mkdir: /builds/slave/test/properties 18:25:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:25:56 INFO - Writing to file /builds/slave/test/properties/build_url 18:25:56 INFO - Contents: 18:25:56 INFO - build_url:https://queue.taskcluster.net/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:25:56 INFO - Running post-action listener: _resource_record_post_action 18:25:56 INFO - Running post-action listener: set_extra_try_arguments 18:25:56 INFO - ##### 18:25:56 INFO - ##### Running populate-webroot step. 18:25:56 INFO - ##### 18:25:56 INFO - Running pre-action listener: _resource_record_pre_action 18:25:56 INFO - Running main action method: populate_webroot 18:25:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:25:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:25:56 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:25:56 INFO - '../fennec_ids.txt'], 18:25:56 INFO - 'tests': ['tcheck2']}, 18:25:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:25:56 INFO - '--tppagecycles', 18:25:56 INFO - '7'], 18:25:56 INFO - 'tests': ['tsvgm']}}, 18:25:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:25:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:25:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:25:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:25:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:25:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:25:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:25:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:56 INFO - 'talos_options': ['--e10s'], 18:25:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:25:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:56 INFO - 'tests': ['damp', 'tps']}, 18:25:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:56 INFO - 'talos_options': ['--e10s'], 18:25:56 INFO - 'tests': ['damp', 'tps']}, 18:25:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:25:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:25:56 INFO - 'other': {'tests': ['a11yr', 18:25:56 INFO - 'ts_paint', 18:25:56 INFO - 'tpaint', 18:25:56 INFO - 'sessionrestore', 18:25:56 INFO - 'sessionrestore_no_auto_restore']}, 18:25:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:25:56 INFO - 'tests': ['a11yr', 18:25:56 INFO - 'ts_paint', 18:25:56 INFO - 'tpaint', 18:25:56 INFO - 'sessionrestore', 18:25:56 INFO - 'sessionrestore_no_auto_restore']}, 18:25:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:25:56 INFO - 'tests': ['a11yr', 18:25:56 INFO - 'ts_paint', 18:25:56 INFO - 'tpaint', 18:25:56 INFO - 'sessionrestore', 18:25:56 INFO - 'sessionrestore_no_auto_restore']}, 18:25:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:25:56 INFO - 'tests': ['a11yr', 18:25:56 INFO - 'ts_paint', 18:25:56 INFO - 'tpaint', 18:25:56 INFO - 'sessionrestore', 18:25:56 INFO - 'sessionrestore_no_auto_restore']}, 18:25:56 INFO - 'other_l64': {'tests': ['a11yr', 18:25:56 INFO - 'ts_paint', 18:25:56 INFO - 'tpaint', 18:25:56 INFO - 'sessionrestore', 18:25:56 INFO - 'sessionrestore_no_auto_restore']}, 18:25:56 INFO - 'other_nol64': {'tests': ['a11yr', 18:25:56 INFO - 'ts_paint', 18:25:56 INFO - 'tpaint', 18:25:56 INFO - 'sessionrestore', 18:25:56 INFO - 'sessionrestore_no_auto_restore']}, 18:25:56 INFO - 'svgr': {'tests': ['tsvgx', 18:25:56 INFO - 'tsvgr_opacity', 18:25:56 INFO - 'tart', 18:25:56 INFO - 'tscrollx', 18:25:56 INFO - 'cart']}, 18:25:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:25:56 INFO - 'tests': ['tsvgx', 18:25:56 INFO - 'tsvgr_opacity', 18:25:56 INFO - 'tart', 18:25:56 INFO - 'tscrollx', 18:25:56 INFO - 'cart']}, 18:25:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:56 INFO - 'tests': ['tp5o']}, 18:25:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:56 INFO - 'talos_options': ['--e10s'], 18:25:56 INFO - 'tests': ['tp5o']}, 18:25:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:56 INFO - 'talos_options': ['--xperf_path', 18:25:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:25:56 INFO - 'tests': ['tp5n']}, 18:25:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:56 INFO - 'talos_options': ['--e10s', 18:25:56 INFO - '--xperf_path', 18:25:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:25:56 INFO - 'tests': ['tp5n']}}, 18:25:56 INFO - 'talos.zip': {'path': '', 18:25:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:25:56 INFO - Running post-action listener: _resource_record_post_action 18:25:56 INFO - ##### 18:25:56 INFO - ##### Running create-virtualenv step. 18:25:56 INFO - ##### 18:25:56 INFO - Running pre-action listener: _resource_record_pre_action 18:25:56 INFO - Running main action method: create_virtualenv 18:25:56 INFO - Creating virtualenv /builds/slave/test/build/venv 18:25:56 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 18:25:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:25:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:25:56 INFO - Using real prefix '/usr' 18:25:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:25:56 INFO - Installing distribute.............................................................................................................................................................................................done. 18:25:58 INFO - Installing pip.................done. 18:25:58 INFO - Return code: 0 18:25:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:25: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')]} 18:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25: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')]} 18:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:58 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 0x7f7c82b20c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f096c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049ac0>, '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 0x204a9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204ae50>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727', '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 18:25:58 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 18:25:58 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 18:25:58 INFO - Using env: {'DISPLAY': ':0', 18:25:58 INFO - 'HOME': '/home/cltbld', 18:25:58 INFO - 'LANG': 'en_US.UTF-8', 18:25:58 INFO - 'LANGUAGE': 'en_US:en', 18:25:58 INFO - 'LOGNAME': 'cltbld', 18:25:58 INFO - 'MAIL': '/var/mail/cltbld', 18:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:58 INFO - 'MOZ_NO_REMOTE': '1', 18:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:58 INFO - 'NO_EM_RESTART': '1', 18:25:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:58 INFO - 'PWD': '/builds/slave/test', 18:25:58 INFO - 'SHELL': '/bin/bash', 18:25:58 INFO - 'SHLVL': '1', 18:25:58 INFO - 'TERM': 'linux', 18:25:58 INFO - 'TMOUT': '86400', 18:25:58 INFO - 'USER': 'cltbld', 18:25:58 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727', 18:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:58 INFO - '_': '/tools/buildbot/bin/python'} 18:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:59 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 18:25:59 INFO - Cleaning up... 18:25:59 INFO - Return code: 0 18:25:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:59 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 0x7f7c82b20c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f096c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049ac0>, '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 0x204a9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204ae50>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727', '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 18:25:59 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 18:25:59 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 18:25:59 INFO - Using env: {'DISPLAY': ':0', 18:25:59 INFO - 'HOME': '/home/cltbld', 18:25:59 INFO - 'LANG': 'en_US.UTF-8', 18:25:59 INFO - 'LANGUAGE': 'en_US:en', 18:25:59 INFO - 'LOGNAME': 'cltbld', 18:25:59 INFO - 'MAIL': '/var/mail/cltbld', 18:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:59 INFO - 'MOZ_NO_REMOTE': '1', 18:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:59 INFO - 'NO_EM_RESTART': '1', 18:25:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:59 INFO - 'PWD': '/builds/slave/test', 18:25:59 INFO - 'SHELL': '/bin/bash', 18:25:59 INFO - 'SHLVL': '1', 18:25:59 INFO - 'TERM': 'linux', 18:25:59 INFO - 'TMOUT': '86400', 18:25:59 INFO - 'USER': 'cltbld', 18:25:59 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727', 18:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:59 INFO - '_': '/tools/buildbot/bin/python'} 18:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:59 INFO - Downloading/unpacking psutil>=0.7.1 18:25:59 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 18:25:59 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 18:25:59 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 18:25:59 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 18:25:59 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 18:25:59 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 18:26:00 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:26:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:26:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:26:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:26:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:26:01 INFO - Installing collected packages: psutil 18:26:01 INFO - Running setup.py install for psutil 18:26:01 INFO - building 'psutil._psutil_linux' extension 18:26:01 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 18:26:01 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 18:26:01 INFO - building 'psutil._psutil_posix' extension 18:26:01 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 18:26:01 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 18:26:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:26:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:26:01 INFO - Successfully installed psutil 18:26:01 INFO - Cleaning up... 18:26:01 INFO - Return code: 0 18:26:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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', '--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 0x7f7c82b20c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f096c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049ac0>, '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 0x204a9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204ae50>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727', '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 18:26:01 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 18:26:01 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 18:26:01 INFO - Using env: {'DISPLAY': ':0', 18:26:01 INFO - 'HOME': '/home/cltbld', 18:26:01 INFO - 'LANG': 'en_US.UTF-8', 18:26:01 INFO - 'LANGUAGE': 'en_US:en', 18:26:01 INFO - 'LOGNAME': 'cltbld', 18:26:01 INFO - 'MAIL': '/var/mail/cltbld', 18:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:01 INFO - 'MOZ_NO_REMOTE': '1', 18:26:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:01 INFO - 'NO_EM_RESTART': '1', 18:26:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:01 INFO - 'PWD': '/builds/slave/test', 18:26:01 INFO - 'SHELL': '/bin/bash', 18:26:01 INFO - 'SHLVL': '1', 18:26:01 INFO - 'TERM': 'linux', 18:26:01 INFO - 'TMOUT': '86400', 18:26:01 INFO - 'USER': 'cltbld', 18:26:01 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727', 18:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:01 INFO - '_': '/tools/buildbot/bin/python'} 18:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:26:01 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 18:26:01 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 18:26:01 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 18:26:01 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 18:26:01 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 18:26:01 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 18:26:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:26:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:26:03 INFO - Installing collected packages: mozsystemmonitor 18:26:03 INFO - Running setup.py install for mozsystemmonitor 18:26:03 INFO - Successfully installed mozsystemmonitor 18:26:03 INFO - Cleaning up... 18:26:03 INFO - Return code: 0 18:26:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7c82b20c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f096c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049ac0>, '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 0x204a9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204ae50>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727', '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 18:26:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:26:03 INFO - Using env: {'DISPLAY': ':0', 18:26:03 INFO - 'HOME': '/home/cltbld', 18:26:03 INFO - 'LANG': 'en_US.UTF-8', 18:26:03 INFO - 'LANGUAGE': 'en_US:en', 18:26:03 INFO - 'LOGNAME': 'cltbld', 18:26:03 INFO - 'MAIL': '/var/mail/cltbld', 18:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:03 INFO - 'MOZ_NO_REMOTE': '1', 18:26:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:03 INFO - 'NO_EM_RESTART': '1', 18:26:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:03 INFO - 'PWD': '/builds/slave/test', 18:26:03 INFO - 'SHELL': '/bin/bash', 18:26:03 INFO - 'SHLVL': '1', 18:26:03 INFO - 'TERM': 'linux', 18:26:03 INFO - 'TMOUT': '86400', 18:26:03 INFO - 'USER': 'cltbld', 18:26:03 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727', 18:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:03 INFO - '_': '/tools/buildbot/bin/python'} 18:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:04 INFO - Downloading/unpacking blobuploader==1.2.4 18:26:04 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 18:26:04 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 18:26:04 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 18:26:04 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 18:26:04 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 18:26:04 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 18:26:05 INFO - Downloading blobuploader-1.2.4.tar.gz 18:26:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:26:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:26:05 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 18:26:05 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 18:26:05 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 18:26:05 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 18:26:05 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 18:26:05 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 18:26:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:26:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:26:06 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 18:26:06 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 18:26:06 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 18:26:06 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 18:26:06 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 18:26:06 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 18:26:06 INFO - Downloading docopt-0.6.1.tar.gz 18:26:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:26:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:26:06 INFO - Installing collected packages: blobuploader, requests, docopt 18:26:06 INFO - Running setup.py install for blobuploader 18:26:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:26:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:26:06 INFO - Running setup.py install for requests 18:26:06 INFO - Running setup.py install for docopt 18:26:06 INFO - Successfully installed blobuploader requests docopt 18:26:06 INFO - Cleaning up... 18:26:06 INFO - Return code: 0 18:26:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:06 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 0x7f7c82b20c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f096c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049ac0>, '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 0x204a9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204ae50>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727', '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 18:26:06 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 18:26:06 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 18:26:06 INFO - Using env: {'DISPLAY': ':0', 18:26:06 INFO - 'HOME': '/home/cltbld', 18:26:06 INFO - 'LANG': 'en_US.UTF-8', 18:26:06 INFO - 'LANGUAGE': 'en_US:en', 18:26:06 INFO - 'LOGNAME': 'cltbld', 18:26:06 INFO - 'MAIL': '/var/mail/cltbld', 18:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:06 INFO - 'MOZ_NO_REMOTE': '1', 18:26:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:06 INFO - 'NO_EM_RESTART': '1', 18:26:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:06 INFO - 'PWD': '/builds/slave/test', 18:26:06 INFO - 'SHELL': '/bin/bash', 18:26:06 INFO - 'SHLVL': '1', 18:26:06 INFO - 'TERM': 'linux', 18:26:06 INFO - 'TMOUT': '86400', 18:26:06 INFO - 'USER': 'cltbld', 18:26:06 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727', 18:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:06 INFO - '_': '/tools/buildbot/bin/python'} 18:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:26:07 INFO - Running setup.py (path:/tmp/pip-RTyDUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:26:07 INFO - Running setup.py (path:/tmp/pip-ShDUNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:26:07 INFO - Running setup.py (path:/tmp/pip-Ktkdfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:26:07 INFO - Running setup.py (path:/tmp/pip-5F7NNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:26:07 INFO - Running setup.py (path:/tmp/pip-xJkNTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:26:07 INFO - Running setup.py (path:/tmp/pip-w7JGyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:26:07 INFO - Running setup.py (path:/tmp/pip-uQYaGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:26:07 INFO - Running setup.py (path:/tmp/pip-EytYNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:26:07 INFO - Running setup.py (path:/tmp/pip-TA6LEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:26:07 INFO - Running setup.py (path:/tmp/pip-Yg5M0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:26:07 INFO - Running setup.py (path:/tmp/pip-6UAsgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:26:07 INFO - Running setup.py (path:/tmp/pip-nXpbkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:26:08 INFO - Running setup.py (path:/tmp/pip-5clc9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:26:08 INFO - Running setup.py (path:/tmp/pip-gwXyEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:08 INFO - Running setup.py (path:/tmp/pip-D2rDp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:26:08 INFO - Running setup.py (path:/tmp/pip-0gyLv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:26:08 INFO - Running setup.py (path:/tmp/pip-dE4OHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:26:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:26:08 INFO - Running setup.py install for manifestparser 18:26:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:26:08 INFO - Running setup.py install for mozcrash 18:26:08 INFO - Running setup.py install for mozdebug 18:26:08 INFO - Running setup.py install for mozdevice 18:26:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:26:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:26:08 INFO - Running setup.py install for mozfile 18:26:08 INFO - Running setup.py install for mozhttpd 18:26:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:26:09 INFO - Running setup.py install for mozinfo 18:26:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:26:09 INFO - Running setup.py install for mozInstall 18:26:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:26:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:26:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:26:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:26:09 INFO - Running setup.py install for mozleak 18:26:09 INFO - Running setup.py install for mozlog 18:26:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:26:09 INFO - Running setup.py install for moznetwork 18:26:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:26:09 INFO - Running setup.py install for mozprocess 18:26:09 INFO - Running setup.py install for mozprofile 18:26:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:26:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:26:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:26:09 INFO - Running setup.py install for mozrunner 18:26:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:26:09 INFO - Running setup.py install for mozscreenshot 18:26:09 INFO - Running setup.py install for moztest 18:26:10 INFO - Running setup.py install for mozversion 18:26:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:26:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:26:10 INFO - Cleaning up... 18:26:10 INFO - Return code: 0 18:26:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f7c82b20c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f096c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049ac0>, '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 0x204a9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204ae50>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727', '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 18:26:10 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 18:26:10 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 18:26:10 INFO - Using env: {'DISPLAY': ':0', 18:26:10 INFO - 'HOME': '/home/cltbld', 18:26:10 INFO - 'LANG': 'en_US.UTF-8', 18:26:10 INFO - 'LANGUAGE': 'en_US:en', 18:26:10 INFO - 'LOGNAME': 'cltbld', 18:26:10 INFO - 'MAIL': '/var/mail/cltbld', 18:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:10 INFO - 'MOZ_NO_REMOTE': '1', 18:26:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:10 INFO - 'NO_EM_RESTART': '1', 18:26:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:10 INFO - 'PWD': '/builds/slave/test', 18:26:10 INFO - 'SHELL': '/bin/bash', 18:26:10 INFO - 'SHLVL': '1', 18:26:10 INFO - 'TERM': 'linux', 18:26:10 INFO - 'TMOUT': '86400', 18:26:10 INFO - 'USER': 'cltbld', 18:26:10 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727', 18:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:10 INFO - '_': '/tools/buildbot/bin/python'} 18:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:26:10 INFO - Running setup.py (path:/tmp/pip-PYvRQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:26:10 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)) 18:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:26:10 INFO - Running setup.py (path:/tmp/pip-3bHoLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:26:10 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)) 18:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:26:10 INFO - Running setup.py (path:/tmp/pip-_uR5Lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:26:10 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)) 18:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:26:10 INFO - Running setup.py (path:/tmp/pip-tCpA8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:26:10 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)) 18:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:26:10 INFO - Running setup.py (path:/tmp/pip-cMmLz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:26:10 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)) 18:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:26:10 INFO - Running setup.py (path:/tmp/pip-wS5LSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:26:10 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)) 18:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:26:10 INFO - Running setup.py (path:/tmp/pip-9XGeKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:26:10 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)) 18:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:26:10 INFO - Running setup.py (path:/tmp/pip-E0lQKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:26:10 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)) 18:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:26:10 INFO - Running setup.py (path:/tmp/pip-Ybup8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:26:11 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)) 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:26:11 INFO - Running setup.py (path:/tmp/pip-npe7vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:26:11 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)) 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:26:11 INFO - Running setup.py (path:/tmp/pip-nERuKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:26:11 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)) 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:26:11 INFO - Running setup.py (path:/tmp/pip-UKWRQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:26:11 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)) 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:26:11 INFO - Running setup.py (path:/tmp/pip-16ltKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:26:11 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)) 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:26:11 INFO - Running setup.py (path:/tmp/pip-rzSp9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:26:11 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)) 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:11 INFO - Running setup.py (path:/tmp/pip-fMtbik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:11 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)) 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:26:11 INFO - Running setup.py (path:/tmp/pip-11LIaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:26:11 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)) 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:26:11 INFO - Running setup.py (path:/tmp/pip-6PJRi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:26:11 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)) 18:26:11 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)) 18:26:11 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)) 18:26:11 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)) 18:26:11 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)) 18:26:11 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)) 18:26:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:13 INFO - Downloading blessings-1.5.1.tar.gz 18:26:13 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 18:26:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:26:13 INFO - Installing collected packages: blessings 18:26:13 INFO - Running setup.py install for blessings 18:26:13 INFO - Successfully installed blessings 18:26:13 INFO - Cleaning up... 18:26:13 INFO - Return code: 0 18:26:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:26:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:26:13 INFO - Reading from file tmpfile_stdout 18:26:13 INFO - Current package versions: 18:26:13 INFO - argparse == 1.2.1 18:26:13 INFO - blessings == 1.5.1 18:26:13 INFO - blobuploader == 1.2.4 18:26:13 INFO - docopt == 0.6.1 18:26:13 INFO - manifestparser == 1.1 18:26:13 INFO - mozInstall == 1.12 18:26:13 INFO - mozcrash == 0.16 18:26:13 INFO - mozdebug == 0.1 18:26:13 INFO - mozdevice == 0.47 18:26:13 INFO - mozfile == 1.2 18:26:13 INFO - mozhttpd == 0.7 18:26:13 INFO - mozinfo == 0.9 18:26:13 INFO - mozleak == 0.1 18:26:13 INFO - mozlog == 3.0 18:26:13 INFO - moznetwork == 0.27 18:26:13 INFO - mozprocess == 0.22 18:26:13 INFO - mozprofile == 0.27 18:26:13 INFO - mozrunner == 6.11 18:26:13 INFO - mozscreenshot == 0.1 18:26:13 INFO - mozsystemmonitor == 0.0 18:26:13 INFO - moztest == 0.7 18:26:13 INFO - mozversion == 1.4 18:26:13 INFO - psutil == 3.1.1 18:26:13 INFO - requests == 1.2.3 18:26:13 INFO - wsgiref == 0.1.2 18:26:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26:13 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')]} 18:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:13 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')]} 18:26:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:13 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 0x7f7c82b20c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f096c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049ac0>, '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 0x204a9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204ae50>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727', '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 18:26:13 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 18:26:13 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 18:26:13 INFO - Using env: {'DISPLAY': ':0', 18:26:13 INFO - 'HOME': '/home/cltbld', 18:26:13 INFO - 'LANG': 'en_US.UTF-8', 18:26:13 INFO - 'LANGUAGE': 'en_US:en', 18:26:13 INFO - 'LOGNAME': 'cltbld', 18:26:13 INFO - 'MAIL': '/var/mail/cltbld', 18:26:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:13 INFO - 'MOZ_NO_REMOTE': '1', 18:26:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:13 INFO - 'NO_EM_RESTART': '1', 18:26:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:13 INFO - 'PWD': '/builds/slave/test', 18:26:13 INFO - 'SHELL': '/bin/bash', 18:26:13 INFO - 'SHLVL': '1', 18:26:13 INFO - 'TERM': 'linux', 18:26:13 INFO - 'TMOUT': '86400', 18:26:13 INFO - 'USER': 'cltbld', 18:26:13 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727', 18:26:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:13 INFO - '_': '/tools/buildbot/bin/python'} 18:26:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:13 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)) 18:26:13 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)) 18:26:13 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)) 18:26:13 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)) 18:26:13 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)) 18:26:13 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)) 18:26:13 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)) 18:26:13 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)) 18:26:13 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)) 18:26:13 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)) 18:26:13 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)) 18:26:13 INFO - Cleaning up... 18:26:13 INFO - Return code: 0 18:26:13 INFO - Running post-action listener: _resource_record_post_action 18:26:13 INFO - Running post-action listener: _start_resource_monitoring 18:26:13 INFO - Starting resource monitoring. 18:26:13 INFO - ##### 18:26:13 INFO - ##### Running install step. 18:26:13 INFO - ##### 18:26:13 INFO - Running pre-action listener: _resource_record_pre_action 18:26:13 INFO - Running main action method: install 18:26:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:26:14 INFO - Reading from file tmpfile_stdout 18:26:14 INFO - Detecting whether we're running mozinstall >=1.0... 18:26:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:26:14 INFO - Reading from file tmpfile_stdout 18:26:14 INFO - Output received: 18:26:14 INFO - Usage: mozinstall [options] installer 18:26:14 INFO - Options: 18:26:14 INFO - -h, --help show this help message and exit 18:26:14 INFO - -d DEST, --destination=DEST 18:26:14 INFO - Directory to install application into. [default: 18:26:14 INFO - "/builds/slave/test"] 18:26:14 INFO - --app=APP Application being installed. [default: firefox] 18:26:14 INFO - mkdir: /builds/slave/test/build/application 18:26:14 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'] 18:26:14 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 18:26:28 INFO - Reading from file tmpfile_stdout 18:26:28 INFO - Output received: 18:26:28 INFO - /builds/slave/test/build/application/firefox/firefox 18:26:28 INFO - Running post-action listener: _resource_record_post_action 18:26:28 INFO - ##### 18:26:28 INFO - ##### Running run-tests step. 18:26:28 INFO - ##### 18:26:28 INFO - Running pre-action listener: _resource_record_pre_action 18:26:28 INFO - Running main action method: run_tests 18:26:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:26:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:26:28 INFO - Python 2.7.3 18:26:28 INFO - Return code: 0 18:26:28 INFO - grabbing minidump binary from tooltool 18:26:28 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')]} 18:26:28 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 0x2049ac0>, '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 0x204a9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204ae50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:26:28 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 18:26:28 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 18:26:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:26:28 INFO - Return code: 0 18:26:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:26:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:26:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:26:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:26:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:26:28 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/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost'] in /builds/slave/test/build 18:26:28 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/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost 18:26:28 INFO - Using env: {'DISPLAY': ':0', 18:26:28 INFO - 'HOME': '/home/cltbld', 18:26:28 INFO - 'LANG': 'en_US.UTF-8', 18:26:28 INFO - 'LANGUAGE': 'en_US:en', 18:26:28 INFO - 'LOGNAME': 'cltbld', 18:26:28 INFO - 'MAIL': '/var/mail/cltbld', 18:26:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:26:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:28 INFO - 'MOZ_NO_REMOTE': '1', 18:26:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:26:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:28 INFO - 'NO_EM_RESTART': '1', 18:26:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:28 INFO - 'PWD': '/builds/slave/test', 18:26:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:26:28 INFO - 'SHELL': '/bin/bash', 18:26:28 INFO - 'SHLVL': '1', 18:26:28 INFO - 'TERM': 'linux', 18:26:28 INFO - 'TMOUT': '86400', 18:26:28 INFO - 'USER': 'cltbld', 18:26:28 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727', 18:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:28 INFO - '_': '/tools/buildbot/bin/python'} 18:26:28 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/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost'] with output_timeout 3600 18:26:28 INFO - mozversion INFO | application_buildid: 20151116173404 18:26:28 INFO - mozversion INFO | application_changeset: ffdc7f22130425020f5d648ef99c10b947541659 18:26:28 INFO - mozversion INFO | application_display_name: Nightly 18:26:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:26:28 INFO - mozversion INFO | application_name: Firefox 18:26:28 INFO - mozversion INFO | application_remotingname: firefox 18:26:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 18:26:28 INFO - mozversion INFO | application_vendor: Mozilla 18:26:28 INFO - mozversion INFO | application_version: 45.0a1 18:26:28 INFO - mozversion INFO | platform_buildid: 20151116173404 18:26:28 INFO - mozversion INFO | platform_changeset: ffdc7f22130425020f5d648ef99c10b947541659 18:26:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 18:26:28 INFO - mozversion INFO | platform_version: 45.0a1 18:26:28 INFO - 2015-11-16 18:26:28,632 DEBUG : using testdate: 1447727188 18:26:28 INFO - 2015-11-16 18:26:28,632 DEBUG : actual date: 1447727188 18:26:28 INFO - 2015-11-16 18:26:28,640 INFO : starting webserver on 'localhost:50812' 18:26:28 INFO - 2015-11-16 18:26:28,641 INFO : Starting test suite talos-linux64-ix-024.e 18:26:28 INFO - 2015-11-16 18:26:28,641 INFO : Starting test dromaeo_css 18:26:28 INFO - 2015-11-16 18:26:28,641 DEBUG : operating with platform_type : linux_ 18:26:28 INFO - 2015-11-16 18:26:28,642 INFO : Initialising browser for dromaeo_css test... 18:26:28 INFO - 2015-11-16 18:26:28,658 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphrFYt1/profile http://localhost:50812/getInfo.html 18:26:34 INFO - 2015-11-16 18:26:34,314 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:26:34 INFO - 2015-11-16 18:26:34,314 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:26:34 INFO - 2015-11-16 18:26:34,314 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:26:34 INFO - 2015-11-16 18:26:34,314 DEBUG : BROWSER_OUTPUT: __metrics 18:26:35 INFO - 2015-11-16 18:26:35,401 INFO : Browser initialized. 18:26:35 INFO - 2015-11-16 18:26:35,402 INFO : Running cycle 1/1 for dromaeo_css test... 18:26:35 INFO - 2015-11-16 18:26:35,402 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphrFYt1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:26:47 INFO - 2015-11-16 18:26:47,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 141299712 18:26:47 INFO - 2015-11-16 18:26:47,389 DEBUG : BROWSER_OUTPUT: 18:27:37 INFO - 2015-11-16 18:27:37,039 DEBUG : BROWSER_OUTPUT: 1447727257034 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] 18:29:48 INFO - 2015-11-16 18:29:48,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50812/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50812/tests/dromaeo/cssquery-ext.html) 18:29:49 INFO - 2015-11-16 18:29:49,584 DEBUG : BROWSER_OUTPUT: RSS: Main: 142454784 18:29:49 INFO - 2015-11-16 18:29:49,584 DEBUG : BROWSER_OUTPUT: 18:32:51 INFO - 2015-11-16 18:32:51,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50812/tests/dromaeo/cssquery-ext.html (next: http://localhost:50812/tests/dromaeo/cssquery-jquery.html) 18:32:52 INFO - 2015-11-16 18:32:52,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 140939264 18:32:52 INFO - 2015-11-16 18:32:52,240 DEBUG : BROWSER_OUTPUT: 18:35:53 INFO - 2015-11-16 18:35:53,998 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50812/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50812/tests/dromaeo/cssquery-mootools.html) 18:35:54 INFO - 2015-11-16 18:35:54,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 141733888 18:35:54 INFO - 2015-11-16 18:35:54,592 DEBUG : BROWSER_OUTPUT: 18:38:56 INFO - 2015-11-16 18:38:56,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50812/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50812/tests/dromaeo/cssquery-prototype.html) 18:38:56 INFO - 2015-11-16 18:38:56,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 139018240 18:38:56 INFO - 2015-11-16 18:38:56,929 DEBUG : BROWSER_OUTPUT: 18:41:59 INFO - 2015-11-16 18:41:59,502 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50812/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50812/tests/dromaeo/cssquery-yui.html) 18:42:00 INFO - 2015-11-16 18:42:00,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 141447168 18:42:00 INFO - 2015-11-16 18:42:00,124 DEBUG : BROWSER_OUTPUT: 18:45:02 INFO - 2015-11-16 18:45:02,488 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50812/tests/dromaeo/cssquery-yui.html (next: http://localhost:50812/tests/dromaeo/cssquery-dojo.html) 18:45:02 INFO - 2015-11-16 18:45:02,746 DEBUG : BROWSER_OUTPUT: RSS: Main: 143888384 18:45:02 INFO - 2015-11-16 18:45:02,747 DEBUG : BROWSER_OUTPUT: 18:45:02 INFO - 2015-11-16 18:45:02,747 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:45:02 INFO - 2015-11-16 18:45:02,747 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:45:02 INFO - 2015-11-16 18:45:02,747 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:45:02 INFO - 2015-11-16 18:45:02,747 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:45:02 INFO - 2015-11-16 18:45:02,747 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2701.702812690604;2742.9725702742967;2778.374865655228;2784.4570308789794;2791.0789439484965;4729.621630269578;4810.254410566364;4850.757462126897;4896.461389247189;4898.926516102257;4741.051789642068;4769.90460190796;4809.350737650416;4830.830920917769;4880.4143502779625;4375.343698445243;4433.866983990485;4466.531014243506;4479.3952816369865;4479.529649386816;4485.215087359716;4560.543945605429;4599.563041511068;4614.976925115369;4626.768661566925;4249.915001699979;4337.262665346899;4360.4331436913;4472.463304403476;4475.48531918827;4482.305242687388;4492.595666390008;4496.662750293708;4507.549245075499;4540;4466.9106617867465;4477.395551600557;4479.3281007848755;4489.528599497038;4526.23054080807;4594.310853371988;4603.5166307537565;4673.789679464398;4764.927891224482;4799.568038876518;5221.738913054332;5238.05714971305;5240.895182096337;5256.185291279858;5285.286486324336;5040.6471546991725;5263.236830659571;5268.657537260104;5268.947310526884;5271.683698978035;4733.0533893221145;4794.2089555223;4801.279808028754;4823.879403014917;4851.830185943475;5326.174442961347;5342.439043900412;5367.194920761917;5376.892462150813;5421.593380496479;4834.154023045953;4930.901381972412;5108.514691104339;5142.845714628567;5145.202493613496;5033.5721463676;5126.15418455958;5133.076046311699;5155.61332900034;5198.2722418861385;5179.896402071938;5193.246979187997;5215.191645294985;5223.503767142115;5257.631965762436;4920.655554111249;5012.548870601663;5060.696358218519;5172.172452407597;5193.350831146106;4281.05816720321;4282.250606143913;4305.870823875289;4328.394024836525;4329.09089091288;3721.0697325668584;3732.9813350933073;3740.5137332146646;3742.5883152853166;3760.1539653578275;4333.111712099075;4393.912121757547;4450.688451808407;4501.797419116082;4519.435070616173;5200.63595548308;5244.501772331622;5249.816256431007;5257.97666341855;5270.10408230594;4507.571780680895;4516.864494065183;4525.0497395546645;4530.093981203772;4563.406757121553;4429.11417716458;4512.142692888341;4551.112533056023;4619.4687610925175;4654.2785868190485;4960.801567937314;4965.35450391454;4983.6760610560195;4986.077575648516;5025.974870125699;4988.27669987857;5260.2898608688865;5271.630985831109;5272;5291.479820627803;4861.635377346643;4873.926891096708;4873.975630121827;4882.170031094794;4886.144924638245;5182.274481572507;5182.922256166085;5187.221916712523;5190.792368305226;5206.479352064915;5252.579793616425;5261.579073674174;5272.78908843642;5284.339457567804;5304.681719096867;4818.10864989978;4914.852554423373;4923.6307276955085;5051.570616497492;5081.5426611605135;5024.246363045572;5025.6482046256415;5038.672486288379;5065.645404821627;5107.565856902205;4928.67963582366;4955;4960.156773348612;4966.553010228952;4990.276409920614;4836.226203807374;4940.60475161979;4958.082754690394;5030.874228144326;5053.065182941021;4981.701097934136;4998.625103117208;5007.173816320412;5008.724520151427;5029.5221953914315 18:45:02 INFO - 2015-11-16 18:45:02,747 DEBUG : BROWSER_OUTPUT: |1;ext.html;564.0354992962032;571.34010218198;572.8828783871451;577.367782278405;583.9737211825468;33698.15754606136;34482.48276275858;34646.826765866135;34682.306353872904;34693.653063469355;38524.80737596308;39287;39379.606203937954;39388.212235755265;39414.80292598533;7994.080680721733;8132.796680083015;8142;8147.388945829057;8148.7147949821765;7919.56442395668;8032.839343213162;8036.27673509384;8037.598120094001;8065.879011814827;7952.681892724313;7959.761207163794;7999;8035.919640803605;8040.437169398145;7990.360771138295;7994.280514753671;8032.277095061472;8041.798955026142;8080.71717489885;7836.294733473957;7994.920050799534;7998.800029999238;8003.879941800819;8013.759587212393;36860.63139368599;36898;37096.07259818526;37201.25597488062;37249.25501489955;2821.5767634854733;2993.536001919684;3127.218195451137;3140.1906473024724;3344;27998.44003119926;28219.858900705363;28272.575911361346;28546.71453285482;29033.854830725923;2734.4531093781125;2756.0767143007115;2761.8342899426098;2787.637607111083;2818.8449635270053;223976;225835;226908;227388;227418;50452;51702.741486292325;53800.19299710508;54708.452915471134;55103.173452398245;50803.23795143076;50940;51085.744571277646;51283;51291.66604170792;11693.123015773852;11733.120015998835;11751.647450576496;11792.115591330685;11794.469248883821;9017.504037278013;9038.367314288069;9046.502442365732;9049.321300902458;9054.411463254868;18706.90646546786;19356.806431935784;19365.612687746165;19512.853586105517;19530.414087577396;6967.581945083311;7102.644867756591;7152.642367881585;7254.492185547067;7271.67277472515;779.174075479993;848.7284069097952;879.463527248378;939.4410325856105;947.8056998315329;25649.42477392951;25978.480430391286;26518.867405663234;26565.601515977276;26584.867075664497;860.7116615933608;915.8305713443034;995.5569771451779;1004.2769206171545;1007.3955626624113;13499.392527336096;13692.863071369358;13861;13933.860661393459;13951.58145255644;279719;282963;284551;284711;284866;45341.77329113333;45357.77321113373;45592.08815823665;45749;45838.31242531365;1150.827375893606;1177.5996161305197;1182.6511179201984;1185.9940700296443;1191.5114802930757;25289.873550632128;25875;25938.481230375663;25943.740562594132;25947.35131621649;40037.39943900902;40262.39606405848;40578.39132413075;40770.592294076676;40789.38815917823;269544;273067;273343;273560;274367;28487.85756071289;28778.856105720173;28957.131286061453;28963.85518072396;29716.40567188601;36456.27087458289;36973.44539831851;37260.441093384165;37644.62355376411;37814.810925945196;31939.36121277515;32036.19909502188;32477.35045299128;33371.83314083414;33443.49834752432;31760.841195793873;32335;32509.512357315132;33235.50146747849;35048.824755876056;32191;32360.352792943537;32396.352072957936;32714.182145446553;33676.66323336833;27846.3038424041;28702;28841.85579072091;29607;29791.27609048869;21944.890275549158;22098.77901220967;22309.888450557642;22406.88796556007;23565.175218867258 18:45:02 INFO - 2015-11-16 18:45:02,747 DEBUG : BROWSER_OUTPUT: |2;jquery.html;337.47522602353337;337.9650736387243;338.9525466434698;339;342.5581000509343;11032.172587055962;11330.830037549444;14960.102393856376;15595.376184952602;15872.920635396822;10103.444310562934;10168.949155254231;10325.741856453593;10403.219758518104;10406.791864162713;4235.258829704797;4358.716683415583;4364.9781751091205;4366.323219900921;4368.519462859099;4317.373980772802;4326.048269380732;4338.175746608134;4664.277037059262;4773.737444440554;4520.208963431386;4643.791029403685;4654;4709.976450117744;4713.033828065256;4558.133954548642;4612.146752850734;4613.100445413146;4616.769161541926;4637.258038713807;3879.3405121129476;3929.6659783918403;3982.5021872265966;4004.0990777075217;4008.2584721826556;11394.37330946806;12294.75410491785;12375.814362784566;12635.368231588383;12647.936760316139;1663.8419350161837;1672.2391311953154;1685.148999755128;1706.5392344067157;2145.8927053647412;8946.105389461067;8951.73144805657;9221.538923053888;9255.861162082507;9261.953690231574;1560.9453669121526;1639.6802623488425;1656.080875114311;1658.8341165883314;1674.1294526846093;52211.21683174755;54909.1763623546;55008.724956375365;55163.17255241174;55841.72079139578;6695.230048544382;6703.329667033355;6726.461883049345;6754.358335958076;6799.966000169968;7747.38020958322;7787.143414224431;7823.29590336861;7827.921720782833;7832.843343133105;4774.498677638798;4774.809007639656;4778.713277203309;4955.231939049453;5035.974820125876;4703.976480117578;4716.056788642217;4901.313816065754;4975.278584605212;4988.675736077216;2993.0721476342405;3024.6975302469577;3033.9836154887917;3040.6047213862057;3052.862621182052;1077.3697387028676;1087.124864484082;1089.2810744908322;1100.1913593508764;1136.9829452558217;362.59389483778335;363.4566323346561;413.3489753638032;434.9521552629208;439.9516053234142;9732.270079744048;9763.316567840184;9870.555824987892;9933.3543319684;9949.701508954742;385.6490593559847;390.04050036908956;391.23513531046734;396.38560231640844;409.3552654569066;5320.802819365612;5356.46435356469;5385.380681221632;5394;5447.53695935842;478475;493312;513753;516116;525892;66909;70140.6492967532;70595.64702176559;70679.64660176769;71257.64371178215;486.4357345479227;492.19526074867133;494.6710437558983;498.89523200127655;498.9251612258118;10681.985211404904;10718.678439646823;10743.08683761889;10776.29954052984;10779.73050673708;32943.83528082344;33237.833810830794;33870.30648467616;34230.65769342275;34991;43019.56980430281;44479.33281000852;45412.54587454083;45437.77281113705;45874.082518348776;6391.073294372383;6412.9679351602945;6419.775307864389;6442.033694945796;6453.645049522133;10718.820929697882;11276.210665253353;11296.6046188383;11391.145664075393;11463.025642820454;9615.278854085831;9985.350952188084;10045.799084018425;10090.293679442368;10366.948165259126;9446.905530944878;9525.761855953378;9532.380395274562;9596.76008099803;9780.853287200556;2376.702912135983;6930.896036559355;8956.28349732033;9930.553125109243;10580.523876425734;6436.420722135031;6455.354464553507;6516.380943810331;6518.934810651833;6554.672266386567;9373.390729602554;9845.458499782295;10009.5495702695;10199.949000254952;10401.68794936153 18:45:02 INFO - 2015-11-16 18:45:02,748 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1500.2048914075544;1613.1530946253217;1664.619593980608;1670.4070055130423;1680.9914051569067;5950.10748387742;6095.51235901128;6972.895406568906;7044.18991815942;7067.611281379522;6774.254831968479;6892.758753443631;6921.480888933325;6927.515073944826;6967.1291088613925;2043.2848503023934;2078.2933802507146;2078.5738923520717;2080.5942841145984;2084.0309256195865;2073.3572592496375;2083.4166433398673;2094.8114669679726;2145.3992881993067;2152.988095595068;2034.3286715383888;2036.378904434147;2048.5185981294385;2054.6917962305697;2055.619710353589;2039.9082041308102;2062.185436752482;2063.226290141197;2063.329417939176;2063.6491796394575;2050.5283784729595;2082.5834833033455;2084.1559168536614;2086.13425428447;2091.393495886191;7082.716691332341;7168.498205125643;7174.605396703179;7176.174739904925;7188.856222875514;4145.0880806222585;4212.157568486315;4219.008532994744;4229.894252643709;4232.195882782262;2722.387462820869;2798.2304866161967;2801.929951751202;2811.4939310924024;2814.1979535832393;1662.609286817597;1686.2749017922288;1692.213120898788;1705.0707364486261;1739.312971376312;9466.29002824784;9578.042195780436;9625.133737963617;9642.180414664692;9665.855012174823;3958.129211573449;3969;4087.6116768906904;4087.795610219477;4090.386442033659;8517.872231916526;8524.147585241426;8536.914630853737;8542.18849209324;8544.2310192083;4210.200061988213;4218.367244913287;4264.616184543406;4265.97867010663;4283.957160428418;3814.084619691254;3819.7899115548357;3852.075501879529;3892.8053597320586;3905.902352441155;3399.0822477931315;3427.3145370925417;3434;3446.6897979181995;3449.6377880322207;1061.830107182847;1080.060347497682;1099.6865893220395;1107.341132026443;1114.409363037575;799.8880156778056;837.8701301298308;1165.8484397028333;1177.3406892140429;1180.887815657511;6828.180618325733;6868.210155832044;6892.276310987374;6897.275786042494;6898.896516552256;967.1730670276812;1034.0848349210853;1040.8022475729588;1041.1722680468895;1084.0839490630406;5374.032674118618;5447.291852059207;5462.426445223274;5473.151661492475;5477.589180811376;7640.083190017233;7664.425168112414;8386.958065209757;8416.831663366698;8425.241728244488;8284.585770711561;8297.170282971654;8328.750137495885;8348.248657620721;8435.24082832548;6368.936310636927;6382.680865956683;6526.902096468557;6540.411362977355;6547.1161393211305;6678.465722742266;6687.498437617295;6752.932470675427;6781.830454238683;6798;7534;7693.307602315818;7699.461037727306;7716.5755883426955;7738.806529836799;7718.6140692964;7862.33170180541;7893.565853878092;7946.8807967881685;7960.960195198987;5813.128030795415;5818.970905145447;5834.27071616048;5926.496247818984;5964.31410387811;6767.492438067066;6825.078614386995;6826.283240259701;6845.897311540231;6849.1096157499205;6311.747530098744;6371.203599550056;6417.2299324081405;6431.158970179692;6497.967510162419;5882.5293976482635;5890.293164820077;5944.395013346286;5962.612430192024;6005.2793664758765;6362.713677884413;6382.457491113308;6388.009858471944;6408.487321014214;6412.9679351602945;5769.567282453749;5772;5776.277965254343;5793;5806.44838740319;5948.405159484017;5994.970025149846;6066.332703402711;6074.969625151846;6097.085437184458 18:45:02 INFO - 2015-11-16 18:45:02,748 DEBUG : BROWSER_OUTPUT: |4;prototype.html;286.07882617970137;294.317184132812;298.2231287496072;299.5282430172479;300.03837700170953;5465.945340546598;5599.412061733516;5617.213590097384;5691.345495268046;5729.828105156842;5605.495505404513;5608.579356548265;5627.887442251153;5631.099024156136;5652.802151924683;4298.46269216348;4298.484181898177;4310.827566897328;4326.09152078064;4326.394304797331;4320.135972805436;4321.395004699345;4321.762303073329;4323.805428755698;4331.4802223733195;4080.9591904081026;4254.298040823261;4255.489341279051;4272;4274.551172126929;4217.0511634881905;4223.324268117102;4248.299030659938;4252.808623611945;4262.9147417051645;3652.579953305351;3654.3604869148057;3654.4152935530456;3656.213914008501;3656.597774244831;5405.135178371442;5408.378036525811;5420;5426.728663566845;5433.429489903582;4467.329900514948;4698.436187657503;4848.612111031144;4872.537108974641;4894.36373271476;5607;5706.9714651426475;5834.64992100471;5892.23400957877;5896.882062358729;3953.1105501262273;3955.0507878109333;3957.426173204898;3959.762414255154;3961.009747563109;6026.276846778414;6111.847203819895;6140.140380346755;6215.595986260879;6231.127642130105;4065.5527891931865;4084.6528045116497;4086.387041943732;4089.8773036808943;4100.302948498763;4155.812988415468;4156.709030367845;4157.97921010399;4159.688023398257;4166.104287578185;4816.494268101869;4831.855044348676;4833.081714474239;4833.806647734052;4838.903221935612;5635.859103522363;5873.20711703923;5875.324337701134;5875.647461152259;5892.292924849045;1426.5506365494837;1439.2803598200899;1454.4400405843614;1454.8908831837443;1457.5117335692662;933.1601558597181;947.4173383369179;954.3319676226669;968.1528662420383;969.1277849934974;5056.797728090909;5090.898182036339;5108.872278193075;5109.08036553424;5119;6061.54538409621;6067.787627433018;6079.088136779518;6086.665233412116;6093.6039157454625;5065.341505604248;5086.54221120101;5098.2097774844215;5110.718910459886;5119.129747942859;3188.3463889902514;3271.787333823294;3302.53764472974;3307.5038744188564;3311.089450401159;5715.828525144252;5724.484796368263;5729;5731.742071606787;5737.110747834009;6170.074488826712;6183.783567575113;6225.968870155711;6241.34465881085;6247.531435142291;5645.915311270416;5692.601517893708;5696.3733989261145;5711.343195532484;5722.284714410699;6142;6194.318624951162;6198.380161983766;6208.410201030895;6213.378662133931;5997.70011499432;6012.969935150471;6033.668148251712;6036.0644100164545;6050.364711705383;5790.623609465371;5811.576163839886;5816.389279125631;5826.563007774519;5848;3963.603639636013;4109.671226301948;4144.730592511477;4145.357469592218;4152.730072545275;5961.612495187799;6151.815445536641;6165.599236049642;6169.537284703575;6181.35095814933;5861.0915308127305;5948.762049517971;5964.642121472725;5965.940340596712;5973.761049557969;5892.9116063258225;5921.2006379138265;5938.970305148447;5947.434993675767;5952.791652292322;5661.433856614306;5788.681622510802;5798.913016304843;5800.854978625399;5835.124731290341;5974.910376344272;5988.401159883977;5991.281046274475;5992.820215393545;5993.041113422006;5782.392848750989;5807.912881306699;5820.097884827689;5828.6502809831545;5849.590528662953 18:45:02 INFO - 2015-11-16 18:45:02,749 DEBUG : BROWSER_OUTPUT: |5;yui.html;639.1209843061396;663.0518358746996;775.52692857357;780.3562061299426;794.6821271491405;11649.068074554036;11789;11814.17300788945;11844.82232766508;11903.64289071327;10625.78748425031;10656.573737050508;10708.036276735093;10708.518116684769;10810.513526891289;730.1202051527896;745.165414735497;746.3842330077681;746.4252525555319;762.6491813765647;739.970401183952;744.7579536650583;747.2079595628651;748.711745977797;749.0786332810646;776.5263189454429;778.3928535742131;778.4084096086958;781.2539025230919;782.8160382310152;773.8529679360931;774.175503089211;775.8448310337955;778.7819410564995;779;565.1522715926111;566.9036263835158;567.3135506037659;567.3730527766841;567.4127278266974;11765.117616178735;11805.173637845353;11807.58673446434;11814.29114253139;11826.11304152192;8410.95904051138;8892.73321800347;8973.685920992799;9514.143727064597;9619.807603847954;8423.663053477854;8513.542460608056;8740.21338079576;9331.066893310683;9349.719508414759;2755.3938133610573;2824.3927555575447;2825.9717402825913;2841.7158284171624;2866.1831378057364;38644.61355386438;39014.609853901384;39029;39039.8048009761;39308.41037384442;6567.1462709848365;6814.420774234147;6838.21360543534;6849.48628852838;6913.3777959983845;10638.627648032436;10646.574137034431;10648.78702425947;10653.360798352123;10682.732931676615;5412.756425960842;5508.14623733322;5570.2201691762375;5576.693281869536;5636.210930469738;3442.4319987202334;3447.9655203447646;3581.4448760442174;3608.585012723518;3637.636236376341;2353.7410884802657;2384.701912260967;2388.379021454434;2392.6411038344386;2392.8923198455764;364.54345624737897;368.34067020033837;368.85798967397744;373.6450372146417;379.50095624254016;403.35060552510436;463.5827755020441;466.4332835604757;469.0969882975259;544.964577302474;6873.621950792654;6982.511224214256;7166.247544007804;7173.175084865203;7184.317489838457;371.5411466838452;414.9813258403379;554.4594020829659;556.262951589138;574.5690731951037;3266.6080070391704;3368.781029233092;3493.7729047611824;3527.400341941876;3546.078019714893;48365;49095.26357104646;49789.751051245235;50043;50186;44540.55459445429;44826.55173448289;44935.55064449379;45421.545784542395;45460;39431.60568394279;41186.1762764743;41468.37797433041;41564.58435415668;42521.936951577074;6249.7500099997305;6297.811065668037;6464.806055818145;6518.641474718936;7583.544987300779;30383.240418989702;30688;31702.524462132624;31945;32186.678133218367;39795.60204397919;40028.59971400365;40398.19203615852;40543;40595.188096238504;6889.414399776075;6945.409640180641;7052.541584796972;7073.787786366417;7102.07673002527;10579.8942010582;10586.629467968583;10922.563097476012;11054.170937179582;11200.663980080612;9238.122378374044;9320.394174378644;9389.953050234704;9705.514724263618;10152.796944061225;9192.816143676955;9632.630311234165;9800.509974501103;9836.754081148028;10232.386056836614;8573;8845.911540884767;9038.09619038091;9296.58165382573;9400.106989835955;8079.313258373104;8567.785805354915;8782.165694259034;8836.779080523038;8926.241269492166;7414.369778568882;7992.280694737501;8044.517328960281;8115.634796434057;8466.830663386821 18:45:02 INFO - 2015-11-16 18:45:02,749 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:45:02 INFO - 2015-11-16 18:45:02,749 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:45:02 INFO - 2015-11-16 18:45:02,749 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,307 18:45:02 INFO - 2015-11-16 18:45:02,749 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:45:02 INFO - 2015-11-16 18:45:02,749 DEBUG : BROWSER_OUTPUT: __startTimestamp1447728302740__endTimestamp 18:45:02 INFO - 2015-11-16 18:45:02,749 DEBUG : BROWSER_OUTPUT: 18:45:02 INFO - 2015-11-16 18:45:02,750 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:45:02 INFO - 2015-11-16 18:45:02,750 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:45:02 INFO - 2015-11-16 18:45:02,750 DEBUG : BROWSER_OUTPUT: 18:45:02 INFO - 2015-11-16 18:45:02,750 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4783.76 Median:4898.93 stddev:509.99 (10.4%) stddev-sans-first:484.69 18:45:02 INFO - 2015-11-16 18:45:02,750 DEBUG : BROWSER_OUTPUT: Values: 2701.7 2743.0 2778.4 2784.5 2791.1 4729.6 4810.3 4850.8 4896.5 4898.9 4741.1 4769.9 4809.4 4830.8 4880.4 4375.3 4433.9 4466.5 4479.4 4479.5 4485.2 4560.5 4599.6 4615.0 4626.8 4249.9 4337.3 4360.4 4472.5 4475.5 4482.3 4492.6 4496.7 4507.5 4540.0 4466.9 4477.4 4479.3 4489.5 4526.2 4594.3 4603.5 4673.8 4764.9 4799.6 5221.7 5238.1 5240.9 5256.2 5285.3 5040.6 5263.2 5268.7 5268.9 5271.7 4733.1 4794.2 4801.3 4823.9 4851.8 5326.2 5342.4 5367.2 5376.9 5421.6 4834.2 4930.9 5108.5 5142.8 5145.2 5033.6 5126.2 5133.1 5155.6 5198.3 5179.9 5193.2 5215.2 5223.5 5257.6 4920.7 5012.5 5060.7 5172.2 5193.4 4281.1 4282.3 4305.9 4328.4 4329.1 3721.1 3733.0 3740.5 3742.6 3760.2 4333.1 4393.9 4450.7 4501.8 4519.4 5200.6 5244.5 5249.8 5258.0 5270.1 4507.6 4516.9 4525.0 4530.1 4563.4 4429.1 4512.1 4551.1 4619.5 4654.3 4960.8 4965.4 4983.7 4986.1 5026.0 4988.3 5260.3 5271.6 5272.0 5291.5 4861.6 4873.9 4874.0 4882.2 4886.1 5182.3 5182.9 5187.2 5190.8 5206.5 5252.6 5261.6 5272.8 5284.3 5304.7 4818.1 4914.9 4923.6 5051.6 5081.5 5024.2 5025.6 5038.7 5065.6 5107.6 4928.7 4955.0 4960.2 4966.6 4990.3 4836.2 4940.6 4958.1 5030.9 5053.1 4981.7 4998.6 5007.2 5008.7 5029.5 18:45:02 INFO - 2015-11-16 18:45:02,750 DEBUG : BROWSER_OUTPUT: 18:45:02 INFO - 2015-11-16 18:45:02,750 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41401.21 Median:33687.41 stddev:68421.99 (203.1%) stddev-sans-first:68545.23 18:45:02 INFO - 2015-11-16 18:45:02,751 DEBUG : BROWSER_OUTPUT: Values: 564.0 571.3 572.9 577.4 584.0 33698.2 34482.5 34646.8 34682.3 34693.7 38524.8 39287.0 39379.6 39388.2 39414.8 7994.1 8132.8 8142.0 8147.4 8148.7 7919.6 8032.8 8036.3 8037.6 8065.9 7952.7 7959.8 7999.0 8035.9 8040.4 7990.4 7994.3 8032.3 8041.8 8080.7 7836.3 7994.9 7998.8 8003.9 8013.8 36860.6 36898.0 37096.1 37201.3 37249.3 2821.6 2993.5 3127.2 3140.2 3344.0 27998.4 28219.9 28272.6 28546.7 29033.9 2734.5 2756.1 2761.8 2787.6 2818.8 223976.0 225835.0 226908.0 227388.0 227418.0 50452.0 51702.7 53800.2 54708.5 55103.2 50803.2 50940.0 51085.7 51283.0 51291.7 11693.1 11733.1 11751.6 11792.1 11794.5 9017.5 9038.4 9046.5 9049.3 9054.4 18706.9 19356.8 19365.6 19512.9 19530.4 6967.6 7102.6 7152.6 7254.5 7271.7 779.2 848.7 879.5 939.4 947.8 25649.4 25978.5 26518.9 26565.6 26584.9 860.7 915.8 995.6 1004.3 1007.4 13499.4 13692.9 13861.0 13933.9 13951.6 279719.0 282963.0 284551.0 284711.0 284866.0 45341.8 45357.8 45592.1 45749.0 45838.3 1150.8 1177.6 1182.7 1186.0 1191.5 25289.9 25875.0 25938.5 25943.7 25947.4 40037.4 40262.4 40578.4 40770.6 40789.4 269544.0 273067.0 273343.0 273560.0 274367.0 28487.9 28778.9 28957.1 28963.9 29716.4 36456.3 36973.4 37260.4 37644.6 37814.8 31939.4 32036.2 32477.4 33371.8 33443.5 31760.8 32335.0 32509.5 33235.5 35048.8 32191.0 32360.4 32396.4 32714.2 33676.7 27846.3 28702.0 28841.9 29607.0 29791.3 21944.9 22098.8 22309.9 22406.9 23565.2 18:45:02 INFO - 2015-11-16 18:45:02,751 DEBUG : BROWSER_OUTPUT: 18:45:02 INFO - 2015-11-16 18:45:02,751 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24919.39 Median:24997.95 stddev:82916.15 (331.7%) stddev-sans-first:83128.20 18:45:02 INFO - 2015-11-16 18:45:02,751 DEBUG : BROWSER_OUTPUT: Values: 337.5 338.0 339.0 339.0 342.6 11032.2 11330.8 14960.1 15595.4 15872.9 10103.4 10168.9 10325.7 10403.2 10406.8 4235.3 4358.7 4365.0 4366.3 4368.5 4317.4 4326.0 4338.2 4664.3 4773.7 4520.2 4643.8 4654.0 4710.0 4713.0 4558.1 4612.1 4613.1 4616.8 4637.3 3879.3 3929.7 3982.5 4004.1 4008.3 11394.4 12294.8 12375.8 12635.4 12647.9 1663.8 1672.2 1685.1 1706.5 2145.9 8946.1 8951.7 9221.5 9255.9 9262.0 1560.9 1639.7 1656.1 1658.8 1674.1 52211.2 54909.2 55008.7 55163.2 55841.7 6695.2 6703.3 6726.5 6754.4 6800.0 7747.4 7787.1 7823.3 7827.9 7832.8 4774.5 4774.8 4778.7 4955.2 5036.0 4704.0 4716.1 4901.3 4975.3 4988.7 2993.1 3024.7 3034.0 3040.6 3052.9 1077.4 1087.1 1089.3 1100.2 1137.0 362.6 363.5 413.3 435.0 440.0 9732.3 9763.3 9870.6 9933.4 9949.7 385.6 390.0 391.2 396.4 409.4 5320.8 5356.5 5385.4 5394.0 5447.5 478475.0 493312.0 513753.0 516116.0 525892.0 66909.0 70140.6 70595.6 70679.6 71257.6 486.4 492.2 494.7 498.9 498.9 10682.0 10718.7 10743.1 10776.3 10779.7 32943.8 33237.8 33870.3 34230.7 34991.0 43019.6 44479.3 45412.5 45437.8 45874.1 6391.1 6413.0 6419.8 6442.0 6453.6 10718.8 11276.2 11296.6 11391.1 11463.0 9615.3 9985.4 10045.8 10090.3 10366.9 9446.9 9525.8 9532.4 9596.8 9780.9 2376.7 6930.9 8956.3 9930.6 10580.5 6436.4 6455.4 6516.4 6518.9 6554.7 9373.4 9845.5 10009.5 10199.9 10401.7 18:45:02 INFO - 2015-11-16 18:45:02,752 DEBUG : BROWSER_OUTPUT: 18:45:02 INFO - 2015-11-16 18:45:02,752 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4972.58 Median:5886.41 stddev:2497.54 (42.4%) stddev-sans-first:2490.91 18:45:02 INFO - 2015-11-16 18:45:02,753 DEBUG : BROWSER_OUTPUT: Values: 1500.2 1613.2 1664.6 1670.4 1681.0 5950.1 6095.5 6972.9 7044.2 7067.6 6774.3 6892.8 6921.5 6927.5 6967.1 2043.3 2078.3 2078.6 2080.6 2084.0 2073.4 2083.4 2094.8 2145.4 2153.0 2034.3 2036.4 2048.5 2054.7 2055.6 2039.9 2062.2 2063.2 2063.3 2063.6 2050.5 2082.6 2084.2 2086.1 2091.4 7082.7 7168.5 7174.6 7176.2 7188.9 4145.1 4212.2 4219.0 4229.9 4232.2 2722.4 2798.2 2801.9 2811.5 2814.2 1662.6 1686.3 1692.2 1705.1 1739.3 9466.3 9578.0 9625.1 9642.2 9665.9 3958.1 3969.0 4087.6 4087.8 4090.4 8517.9 8524.1 8536.9 8542.2 8544.2 4210.2 4218.4 4264.6 4266.0 4284.0 3814.1 3819.8 3852.1 3892.8 3905.9 3399.1 3427.3 3434.0 3446.7 3449.6 1061.8 1080.1 1099.7 1107.3 1114.4 799.9 837.9 1165.8 1177.3 1180.9 6828.2 6868.2 6892.3 6897.3 6898.9 967.2 1034.1 1040.8 1041.2 1084.1 5374.0 5447.3 5462.4 5473.2 5477.6 7640.1 7664.4 8387.0 8416.8 8425.2 8284.6 8297.2 8328.8 8348.2 8435.2 6368.9 6382.7 6526.9 6540.4 6547.1 6678.5 6687.5 6752.9 6781.8 6798.0 7534.0 7693.3 7699.5 7716.6 7738.8 7718.6 7862.3 7893.6 7946.9 7961.0 5813.1 5819.0 5834.3 5926.5 5964.3 6767.5 6825.1 6826.3 6845.9 6849.1 6311.7 6371.2 6417.2 6431.2 6498.0 5882.5 5890.3 5944.4 5962.6 6005.3 6362.7 6382.5 6388.0 6408.5 6413.0 5769.6 5772.0 5776.3 5793.0 5806.4 5948.4 5995.0 6066.3 6075.0 6097.1 18:45:02 INFO - 2015-11-16 18:45:02,753 DEBUG : BROWSER_OUTPUT: 18:45:02 INFO - 2015-11-16 18:45:02,753 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4849.33 Median:5622.55 stddev:1461.41 (26.0%) stddev-sans-first:1424.80 18:45:02 INFO - 2015-11-16 18:45:02,753 DEBUG : BROWSER_OUTPUT: Values: 286.1 294.3 298.2 299.5 300.0 5465.9 5599.4 5617.2 5691.3 5729.8 5605.5 5608.6 5627.9 5631.1 5652.8 4298.5 4298.5 4310.8 4326.1 4326.4 4320.1 4321.4 4321.8 4323.8 4331.5 4081.0 4254.3 4255.5 4272.0 4274.6 4217.1 4223.3 4248.3 4252.8 4262.9 3652.6 3654.4 3654.4 3656.2 3656.6 5405.1 5408.4 5420.0 5426.7 5433.4 4467.3 4698.4 4848.6 4872.5 4894.4 5607.0 5707.0 5834.6 5892.2 5896.9 3953.1 3955.1 3957.4 3959.8 3961.0 6026.3 6111.8 6140.1 6215.6 6231.1 4065.6 4084.7 4086.4 4089.9 4100.3 4155.8 4156.7 4158.0 4159.7 4166.1 4816.5 4831.9 4833.1 4833.8 4838.9 5635.9 5873.2 5875.3 5875.6 5892.3 1426.6 1439.3 1454.4 1454.9 1457.5 933.2 947.4 954.3 968.2 969.1 5056.8 5090.9 5108.9 5109.1 5119.0 6061.5 6067.8 6079.1 6086.7 6093.6 5065.3 5086.5 5098.2 5110.7 5119.1 3188.3 3271.8 3302.5 3307.5 3311.1 5715.8 5724.5 5729.0 5731.7 5737.1 6170.1 6183.8 6226.0 6241.3 6247.5 5645.9 5692.6 5696.4 5711.3 5722.3 6142.0 6194.3 6198.4 6208.4 6213.4 5997.7 6013.0 6033.7 6036.1 6050.4 5790.6 5811.6 5816.4 5826.6 5848.0 3963.6 4109.7 4144.7 4145.4 4152.7 5961.6 6151.8 6165.6 6169.5 6181.4 5861.1 5948.8 5964.6 5965.9 5973.8 5892.9 5921.2 5939.0 5947.4 5952.8 5661.4 5788.7 5798.9 5800.9 5835.1 5974.9 5988.4 5991.3 5992.8 5993.0 5782.4 5807.9 5820.1 5828.7 5849.6 18:45:02 INFO - 2015-11-16 18:45:02,753 DEBUG : BROWSER_OUTPUT: 18:45:02 INFO - 2015-11-16 18:45:02,753 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11558.46 Median:3031.30 stddev:13938.13 (459.8%) stddev-sans-first:13953.11 18:45:02 INFO - 2015-11-16 18:45:02,754 DEBUG : BROWSER_OUTPUT: Values: 639.1 663.1 775.5 780.4 794.7 11649.1 11789.0 11814.2 11844.8 11903.6 10625.8 10656.6 10708.0 10708.5 10810.5 730.1 745.2 746.4 746.4 762.6 740.0 744.8 747.2 748.7 749.1 776.5 778.4 778.4 781.3 782.8 773.9 774.2 775.8 778.8 779.0 565.2 566.9 567.3 567.4 567.4 11765.1 11805.2 11807.6 11814.3 11826.1 8411.0 8892.7 8973.7 9514.1 9619.8 8423.7 8513.5 8740.2 9331.1 9349.7 2755.4 2824.4 2826.0 2841.7 2866.2 38644.6 39014.6 39029.0 39039.8 39308.4 6567.1 6814.4 6838.2 6849.5 6913.4 10638.6 10646.6 10648.8 10653.4 10682.7 5412.8 5508.1 5570.2 5576.7 5636.2 3442.4 3448.0 3581.4 3608.6 3637.6 2353.7 2384.7 2388.4 2392.6 2392.9 364.5 368.3 368.9 373.6 379.5 403.4 463.6 466.4 469.1 545.0 6873.6 6982.5 7166.2 7173.2 7184.3 371.5 415.0 554.5 556.3 574.6 3266.6 3368.8 3493.8 3527.4 3546.1 48365.0 49095.3 49789.8 50043.0 50186.0 44540.6 44826.6 44935.6 45421.5 45460.0 39431.6 41186.2 41468.4 41564.6 42521.9 6249.8 6297.8 6464.8 6518.6 7583.5 30383.2 30688.0 31702.5 31945.0 32186.7 39795.6 40028.6 40398.2 40543.0 40595.2 6889.4 6945.4 7052.5 7073.8 7102.1 10579.9 10586.6 10922.6 11054.2 11200.7 9238.1 9320.4 9390.0 9705.5 10152.8 9192.8 9632.6 9800.5 9836.8 10232.4 8573.0 8845.9 9038.1 9296.6 9400.1 8079.3 8567.8 8782.2 8836.8 8926.2 7414.4 7992.3 8044.5 8115.6 8466.8 18:45:02 INFO - 2015-11-16 18:45:02,754 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:45:02 INFO - 2015-11-16 18:45:02,755 DEBUG : BROWSER_OUTPUT: 18:45:03 INFO - 2015-11-16 18:45:03,326 INFO : Browser exited with error code: 0 18:45:03 INFO - 2015-11-16 18:45:03,342 INFO : Completed test dromaeo_css (00:18:34) 18:45:03 INFO - 2015-11-16 18:45:03,342 INFO : Starting test kraken 18:45:03 INFO - 2015-11-16 18:45:03,342 DEBUG : operating with platform_type : linux_ 18:45:03 INFO - 2015-11-16 18:45:03,342 INFO : Initialising browser for kraken test... 18:45:03 INFO - 2015-11-16 18:45:03,348 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmQ2g0_/profile http://localhost:50812/getInfo.html 18:45:07 INFO - 2015-11-16 18:45:07,798 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:45:07 INFO - 2015-11-16 18:45:07,799 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:45:07 INFO - 2015-11-16 18:45:07,799 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:45:07 INFO - 2015-11-16 18:45:07,799 DEBUG : BROWSER_OUTPUT: __metrics 18:45:08 INFO - 2015-11-16 18:45:08,805 INFO : Browser initialized. 18:45:08 INFO - 2015-11-16 18:45:08,806 INFO : Running cycle 1/1 for kraken test... 18:45:08 INFO - 2015-11-16 18:45:08,806 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmQ2g0_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:45:20 INFO - 2015-11-16 18:45:20,785 DEBUG : BROWSER_OUTPUT: RSS: Main: 141574144 18:45:20 INFO - 2015-11-16 18:45:20,785 DEBUG : BROWSER_OUTPUT: 18:45:23 INFO - 2015-11-16 18:45:23,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50812/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50812/tests/kraken/driver.html?testName=audio-beat-detection) 18:45:23 INFO - 2015-11-16 18:45:23,986 DEBUG : BROWSER_OUTPUT: RSS: Main: 141643776 18:45:23 INFO - 2015-11-16 18:45:23,987 DEBUG : BROWSER_OUTPUT: 18:45:26 INFO - 2015-11-16 18:45:26,750 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50812/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50812/tests/kraken/driver.html?testName=audio-dft) 18:45:27 INFO - 2015-11-16 18:45:27,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 142430208 18:45:27 INFO - 2015-11-16 18:45:27,353 DEBUG : BROWSER_OUTPUT: 18:45:30 INFO - 2015-11-16 18:45:30,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50812/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50812/tests/kraken/driver.html?testName=audio-fft) 18:45:30 INFO - 2015-11-16 18:45:30,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 136278016 18:45:30 INFO - 2015-11-16 18:45:30,863 DEBUG : BROWSER_OUTPUT: 18:45:32 INFO - 2015-11-16 18:45:32,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50812/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50812/tests/kraken/driver.html?testName=audio-oscillator) 18:45:33 INFO - 2015-11-16 18:45:33,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 137175040 18:45:33 INFO - 2015-11-16 18:45:33,551 DEBUG : BROWSER_OUTPUT: 18:45:35 INFO - 2015-11-16 18:45:35,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50812/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50812/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:45:36 INFO - 2015-11-16 18:45:36,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 139321344 18:45:36 INFO - 2015-11-16 18:45:36,359 DEBUG : BROWSER_OUTPUT: 18:45:39 INFO - 2015-11-16 18:45:39,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50812/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50812/tests/kraken/driver.html?testName=imaging-darkroom) 18:45:40 INFO - 2015-11-16 18:45:40,010 DEBUG : BROWSER_OUTPUT: RSS: Main: 138555392 18:45:40 INFO - 2015-11-16 18:45:40,010 DEBUG : BROWSER_OUTPUT: 18:45:43 INFO - 2015-11-16 18:45:43,497 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50812/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50812/tests/kraken/driver.html?testName=imaging-desaturate) 18:45:44 INFO - 2015-11-16 18:45:44,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 136425472 18:45:44 INFO - 2015-11-16 18:45:44,084 DEBUG : BROWSER_OUTPUT: 18:45:47 INFO - 2015-11-16 18:45:47,043 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50812/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50812/tests/kraken/driver.html?testName=json-parse-financial) 18:45:47 INFO - 2015-11-16 18:45:47,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 136921088 18:45:47 INFO - 2015-11-16 18:45:47,645 DEBUG : BROWSER_OUTPUT: 18:45:49 INFO - 2015-11-16 18:45:49,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50812/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50812/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:45:49 INFO - 2015-11-16 18:45:49,991 DEBUG : BROWSER_OUTPUT: RSS: Main: 138604544 18:45:49 INFO - 2015-11-16 18:45:49,992 DEBUG : BROWSER_OUTPUT: 18:45:51 INFO - 2015-11-16 18:45:51,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50812/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50812/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:45:52 INFO - 2015-11-16 18:45:52,517 DEBUG : BROWSER_OUTPUT: RSS: Main: 138891264 18:45:52 INFO - 2015-11-16 18:45:52,517 DEBUG : BROWSER_OUTPUT: 18:45:54 INFO - 2015-11-16 18:45:54,708 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50812/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50812/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:45:55 INFO - 2015-11-16 18:45:55,294 DEBUG : BROWSER_OUTPUT: RSS: Main: 139165696 18:45:55 INFO - 2015-11-16 18:45:55,294 DEBUG : BROWSER_OUTPUT: 18:45:57 INFO - 2015-11-16 18:45:57,855 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50812/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:45:58 INFO - 2015-11-16 18:45:58,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 139526144 18:45:58 INFO - 2015-11-16 18:45:58,457 DEBUG : BROWSER_OUTPUT: 18:46:01 INFO - 2015-11-16 18:46:01,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:46:01 INFO - 2015-11-16 18:46:01,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 139223040 18:46:01 INFO - 2015-11-16 18:46:01,714 DEBUG : BROWSER_OUTPUT: 18:46:03 INFO - 2015-11-16 18:46:03,489 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50812/tests/kraken/driver.html?testName=ai-astar) 18:46:03 INFO - 2015-11-16 18:46:03,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 138338304 18:46:03 INFO - 2015-11-16 18:46:03,740 DEBUG : BROWSER_OUTPUT: 18:46:03 INFO - 2015-11-16 18:46:03,744 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:46:03 INFO - 2015-11-16 18:46:03,744 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:46:03 INFO - 2015-11-16 18:46:03,744 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:46:03 INFO - 2015-11-16 18:46:03,744 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:46:03 INFO - 2015-11-16 18:46:03,744 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;106;115;112;111;124;112;111;113;113 18:46:03 INFO - 2015-11-16 18:46:03,745 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;130;154;178;130;158;164;133;163;142 18:46:03 INFO - 2015-11-16 18:46:03,745 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;165;163;162;162;165;169;162;169;165 18:46:03 INFO - 2015-11-16 18:46:03,745 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;72;73;73;73;73;138;73;73;79 18:46:03 INFO - 2015-11-16 18:46:03,745 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;135;92;91;92;126;92;92;129 18:46:03 INFO - 2015-11-16 18:46:03,745 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;110;111;110;110;110;110;110 18:46:03 INFO - 2015-11-16 18:46:03,745 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;150;149;148;149;149;157;150;151;150 18:46:03 INFO - 2015-11-16 18:46:03,745 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;96;95;96;97;95;96 18:46:03 INFO - 2015-11-16 18:46:03,745 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;72;74;74;76;72;74;74;74;73 18:46:03 INFO - 2015-11-16 18:46:03,746 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;69;70;70;69;69;73 18:46:03 INFO - 2015-11-16 18:46:03,746 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;85;84;84;93;84;83;83;82 18:46:03 INFO - 2015-11-16 18:46:03,746 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;122;120;123;122;121;123;131;127;121 18:46:03 INFO - 2015-11-16 18:46:03,746 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;155;154;167;142;149;151;151;153;157;149 18:46:03 INFO - 2015-11-16 18:46:03,746 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;70;73;74;72;70;69;73;70;72 18:46:03 INFO - 2015-11-16 18:46:03,746 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:46:03 INFO - 2015-11-16 18:46:03,746 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:46:03 INFO - 2015-11-16 18:46:03,747 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,780 18:46:03 INFO - 2015-11-16 18:46:03,747 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:46:03 INFO - 2015-11-16 18:46:03,747 DEBUG : BROWSER_OUTPUT: __startTimestamp1447728363742__endTimestamp 18:46:03 INFO - 2015-11-16 18:46:03,747 DEBUG : BROWSER_OUTPUT: 18:46:03 INFO - 2015-11-16 18:46:03,755 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:46:03 INFO - 2015-11-16 18:46:03,755 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:46:03 INFO - 2015-11-16 18:46:03,755 DEBUG : BROWSER_OUTPUT: 18:46:03 INFO - 2015-11-16 18:46:03,755 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.90 Median:112.50 stddev:4.53 (4.0%) stddev-sans-first:4.80 18:46:03 INFO - 2015-11-16 18:46:03,755 DEBUG : BROWSER_OUTPUT: Values: 112.0 106.0 115.0 112.0 111.0 124.0 112.0 111.0 113.0 113.0 18:46:03 INFO - 2015-11-16 18:46:03,755 DEBUG : BROWSER_OUTPUT: 18:46:03 INFO - 2015-11-16 18:46:03,755 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.00 Median:158.00 stddev:16.45 (10.4%) stddev-sans-first:17.25 18:46:03 INFO - 2015-11-16 18:46:03,755 DEBUG : BROWSER_OUTPUT: Values: 158.0 130.0 154.0 178.0 130.0 158.0 164.0 133.0 163.0 142.0 18:46:03 INFO - 2015-11-16 18:46:03,756 DEBUG : BROWSER_OUTPUT: 18:46:03 INFO - 2015-11-16 18:46:03,756 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.60 Median:165.00 stddev:2.63 (1.6%) stddev-sans-first:2.78 18:46:03 INFO - 2015-11-16 18:46:03,756 DEBUG : BROWSER_OUTPUT: Values: 164.0 165.0 163.0 162.0 162.0 165.0 169.0 162.0 169.0 165.0 18:46:03 INFO - 2015-11-16 18:46:03,756 DEBUG : BROWSER_OUTPUT: 18:46:03 INFO - 2015-11-16 18:46:03,756 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:73.00 stddev:20.44 (28.0%) stddev-sans-first:21.56 18:46:03 INFO - 2015-11-16 18:46:03,757 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 73.0 73.0 73.0 73.0 138.0 73.0 73.0 79.0 18:46:03 INFO - 2015-11-16 18:46:03,757 DEBUG : BROWSER_OUTPUT: 18:46:03 INFO - 2015-11-16 18:46:03,757 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.30 Median:92.00 stddev:18.55 (20.2%) stddev-sans-first:19.22 18:46:03 INFO - 2015-11-16 18:46:03,757 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 135.0 92.0 91.0 92.0 126.0 92.0 92.0 129.0 18:46:03 INFO - 2015-11-16 18:46:03,758 DEBUG : BROWSER_OUTPUT: 18:46:03 INFO - 2015-11-16 18:46:03,758 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 18:46:03 INFO - 2015-11-16 18:46:03,758 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 110.0 111.0 110.0 110.0 110.0 110.0 110.0 18:46:03 INFO - 2015-11-16 18:46:03,758 DEBUG : BROWSER_OUTPUT: 18:46:03 INFO - 2015-11-16 18:46:03,758 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.00 stddev:2.53 (1.7%) stddev-sans-first:2.65 18:46:03 INFO - 2015-11-16 18:46:03,759 DEBUG : BROWSER_OUTPUT: Values: 149.0 150.0 149.0 148.0 149.0 149.0 157.0 150.0 151.0 150.0 18:46:03 INFO - 2015-11-16 18:46:03,759 DEBUG : BROWSER_OUTPUT: 18:46:03 INFO - 2015-11-16 18:46:03,759 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 18:46:03 INFO - 2015-11-16 18:46:03,759 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 96.0 95.0 96.0 97.0 95.0 96.0 18:46:03 INFO - 2015-11-16 18:46:03,760 DEBUG : BROWSER_OUTPUT: 18:46:03 INFO - 2015-11-16 18:46:03,760 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.50 Median:74.00 stddev:1.27 (1.7%) stddev-sans-first:1.22 18:46:03 INFO - 2015-11-16 18:46:03,760 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 74.0 74.0 76.0 72.0 74.0 74.0 74.0 73.0 18:46:03 INFO - 2015-11-16 18:46:03,760 DEBUG : BROWSER_OUTPUT: 18:46:03 INFO - 2015-11-16 18:46:03,760 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:69.00 stddev:1.26 (1.8%) stddev-sans-first:1.32 18:46:03 INFO - 2015-11-16 18:46:03,760 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 69.0 70.0 70.0 69.0 69.0 73.0 18:46:03 INFO - 2015-11-16 18:46:03,761 DEBUG : BROWSER_OUTPUT: 18:46:03 INFO - 2015-11-16 18:46:03,761 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.00 stddev:3.20 (3.8%) stddev-sans-first:3.28 18:46:03 INFO - 2015-11-16 18:46:03,761 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 85.0 84.0 84.0 93.0 84.0 83.0 83.0 82.0 18:46:03 INFO - 2015-11-16 18:46:03,761 DEBUG : BROWSER_OUTPUT: 18:46:03 INFO - 2015-11-16 18:46:03,761 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:123.00 stddev:3.61 (2.9%) stddev-sans-first:3.50 18:46:03 INFO - 2015-11-16 18:46:03,761 DEBUG : BROWSER_OUTPUT: Values: 128.0 122.0 120.0 123.0 122.0 121.0 123.0 131.0 127.0 121.0 18:46:03 INFO - 2015-11-16 18:46:03,761 DEBUG : BROWSER_OUTPUT: 18:46:03 INFO - 2015-11-16 18:46:03,761 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.80 Median:153.50 stddev:6.48 (4.2%) stddev-sans-first:6.82 18:46:03 INFO - 2015-11-16 18:46:03,761 DEBUG : BROWSER_OUTPUT: Values: 155.0 154.0 167.0 142.0 149.0 151.0 151.0 153.0 157.0 149.0 18:46:03 INFO - 2015-11-16 18:46:03,761 DEBUG : BROWSER_OUTPUT: 18:46:03 INFO - 2015-11-16 18:46:03,762 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:72.00 stddev:1.65 (2.3%) stddev-sans-first:1.74 18:46:03 INFO - 2015-11-16 18:46:03,762 DEBUG : BROWSER_OUTPUT: Values: 72.0 70.0 73.0 74.0 72.0 70.0 69.0 73.0 70.0 72.0 18:46:03 INFO - 2015-11-16 18:46:03,762 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:46:03 INFO - 2015-11-16 18:46:03,762 DEBUG : BROWSER_OUTPUT: 18:46:04 INFO - 2015-11-16 18:46:04,689 INFO : Browser exited with error code: 0 18:46:04 INFO - 2015-11-16 18:46:04,740 INFO : Completed test kraken (00:01:01) 18:46:04 INFO - 2015-11-16 18:46:04,740 INFO : Starting test v8_7 18:46:04 INFO - 2015-11-16 18:46:04,740 DEBUG : operating with platform_type : linux_ 18:46:04 INFO - 2015-11-16 18:46:04,741 INFO : Initialising browser for v8_7 test... 18:46:04 INFO - 2015-11-16 18:46:04,747 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo3uBY7/profile http://localhost:50812/getInfo.html 18:46:09 INFO - 2015-11-16 18:46:09,148 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:46:09 INFO - 2015-11-16 18:46:09,148 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:46:09 INFO - 2015-11-16 18:46:09,148 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:46:09 INFO - 2015-11-16 18:46:09,148 DEBUG : BROWSER_OUTPUT: __metrics 18:46:10 INFO - 2015-11-16 18:46:10,217 INFO : Browser initialized. 18:46:10 INFO - 2015-11-16 18:46:10,218 INFO : Running cycle 1/1 for v8_7 test... 18:46:10 INFO - 2015-11-16 18:46:10,218 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo3uBY7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:46:22 INFO - 2015-11-16 18:46:22,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 141488128 18:46:22 INFO - 2015-11-16 18:46:22,161 DEBUG : BROWSER_OUTPUT: 18:46:43 INFO - 2015-11-16 18:46:43,670 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50812/tests/v8_7/run.html (next: http://localhost:50812/tests/v8_7/run.html) 18:46:43 INFO - 2015-11-16 18:46:43,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 138502144 18:46:43 INFO - 2015-11-16 18:46:43,929 DEBUG : BROWSER_OUTPUT: 18:46:43 INFO - 2015-11-16 18:46:43,929 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:46:43 INFO - 2015-11-16 18:46:43,929 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:46:43 INFO - 2015-11-16 18:46:43,929 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:46:43 INFO - 2015-11-16 18:46:43,929 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:46:43 INFO - 2015-11-16 18:46:43,929 DEBUG : BROWSER_OUTPUT: |0;Richards;163.96130513198884 18:46:43 INFO - 2015-11-16 18:46:43,930 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.8761213972132 18:46:43 INFO - 2015-11-16 18:46:43,930 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.17364600781684 18:46:43 INFO - 2015-11-16 18:46:43,930 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 18:46:43 INFO - 2015-11-16 18:46:43,930 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1068.3760683760684 18:46:43 INFO - 2015-11-16 18:46:43,930 DEBUG : BROWSER_OUTPUT: |5;Earley;734.7538574577517 18:46:43 INFO - 2015-11-16 18:46:43,930 DEBUG : BROWSER_OUTPUT: |6;Boyer;12432.098765432098 18:46:43 INFO - 2015-11-16 18:46:43,930 DEBUG : BROWSER_OUTPUT: |7;RegExp;25666.666666666668 18:46:43 INFO - 2015-11-16 18:46:43,930 DEBUG : BROWSER_OUTPUT: |8;Splay;610.8075288403157 18:46:43 INFO - 2015-11-16 18:46:43,931 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 18:46:43 INFO - 2015-11-16 18:46:43,931 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:46:43 INFO - 2015-11-16 18:46:43,931 DEBUG : BROWSER_OUTPUT: __startTimestamp1447728403922__endTimestamp 18:46:43 INFO - 2015-11-16 18:46:43,931 DEBUG : BROWSER_OUTPUT: 18:46:43 INFO - 2015-11-16 18:46:43,931 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:46:43 INFO - 2015-11-16 18:46:43,931 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:46:43 INFO - 2015-11-16 18:46:43,931 DEBUG : BROWSER_OUTPUT: 18:46:43 INFO - 2015-11-16 18:46:43,931 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.96 Median:163.96 stddev:0.00 (0.0%) 18:46:43 INFO - 2015-11-16 18:46:43,931 DEBUG : BROWSER_OUTPUT: Values: 164.0 18:46:43 INFO - 2015-11-16 18:46:43,931 DEBUG : BROWSER_OUTPUT: 18:46:43 INFO - 2015-11-16 18:46:43,931 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.88 Median:190.88 stddev:0.00 (0.0%) 18:46:43 INFO - 2015-11-16 18:46:43,931 DEBUG : BROWSER_OUTPUT: Values: 190.9 18:46:43 INFO - 2015-11-16 18:46:43,932 DEBUG : BROWSER_OUTPUT: 18:46:43 INFO - 2015-11-16 18:46:43,932 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 18:46:43 INFO - 2015-11-16 18:46:43,932 DEBUG : BROWSER_OUTPUT: Values: 279.2 18:46:43 INFO - 2015-11-16 18:46:43,932 DEBUG : BROWSER_OUTPUT: 18:46:43 INFO - 2015-11-16 18:46:43,932 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 18:46:43 INFO - 2015-11-16 18:46:43,932 DEBUG : BROWSER_OUTPUT: Values: 5035.2 18:46:43 INFO - 2015-11-16 18:46:43,932 DEBUG : BROWSER_OUTPUT: 18:46:43 INFO - 2015-11-16 18:46:43,932 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1068.38 Median:1068.38 stddev:0.00 (0.0%) 18:46:43 INFO - 2015-11-16 18:46:43,932 DEBUG : BROWSER_OUTPUT: Values: 1068.4 18:46:43 INFO - 2015-11-16 18:46:43,932 DEBUG : BROWSER_OUTPUT: 18:46:43 INFO - 2015-11-16 18:46:43,932 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:734.75 Median:734.75 stddev:0.00 (0.0%) 18:46:43 INFO - 2015-11-16 18:46:43,933 DEBUG : BROWSER_OUTPUT: Values: 734.8 18:46:43 INFO - 2015-11-16 18:46:43,933 DEBUG : BROWSER_OUTPUT: 18:46:43 INFO - 2015-11-16 18:46:43,933 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12432.10 Median:12432.10 stddev:0.00 (0.0%) 18:46:43 INFO - 2015-11-16 18:46:43,933 DEBUG : BROWSER_OUTPUT: Values: 12432.1 18:46:43 INFO - 2015-11-16 18:46:43,933 DEBUG : BROWSER_OUTPUT: 18:46:43 INFO - 2015-11-16 18:46:43,933 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25666.67 Median:25666.67 stddev:0.00 (0.0%) 18:46:43 INFO - 2015-11-16 18:46:43,933 DEBUG : BROWSER_OUTPUT: Values: 25666.7 18:46:43 INFO - 2015-11-16 18:46:43,933 DEBUG : BROWSER_OUTPUT: 18:46:43 INFO - 2015-11-16 18:46:43,933 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:610.81 Median:610.81 stddev:0.00 (0.0%) 18:46:43 INFO - 2015-11-16 18:46:43,934 DEBUG : BROWSER_OUTPUT: Values: 610.8 18:46:43 INFO - 2015-11-16 18:46:43,934 DEBUG : BROWSER_OUTPUT: 18:46:43 INFO - 2015-11-16 18:46:43,934 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 18:46:43 INFO - 2015-11-16 18:46:43,934 DEBUG : BROWSER_OUTPUT: Values: 4830.9 18:46:43 INFO - 2015-11-16 18:46:43,934 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:46:43 INFO - 2015-11-16 18:46:43,934 DEBUG : BROWSER_OUTPUT: 18:46:44 INFO - 2015-11-16 18:46:44,837 INFO : Browser exited with error code: 0 18:46:44 INFO - 2015-11-16 18:46:44,855 INFO : Completed test v8_7 (00:00:40) 18:46:44 INFO - 2015-11-16 18:46:44,916 INFO : Completed test suite (00:20:16) 18:46:44 INFO - 2015-11-16 18:46:44,916 DEBUG : Working with test: dromaeo_css 18:46:44 INFO - 2015-11-16 18:46:44,916 DEBUG : Generating results file: dromaeo_css 18:46:44 INFO - 2015-11-16 18:46:44,917 DEBUG : Working with test: kraken 18:46:44 INFO - 2015-11-16 18:46:44,917 DEBUG : Generating results file: kraken 18:46:44 INFO - 2015-11-16 18:46:44,917 INFO : javascript benchmark 18:46:44 INFO - 2015-11-16 18:46:44,918 DEBUG : Working with test: v8_7 18:46:44 INFO - 2015-11-16 18:46:44,918 DEBUG : Generating results file: v8_7 18:46:44 INFO - 2015-11-16 18:46:44,918 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:46:44 INFO - 2015-11-16 18:46:44,993 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 18:46:44 INFO - 2015-11-16 18:46:44,993 DEBUG : process_Request line: dromaeo_css 5988.21 graph.html#tests=[[72,132,43]] 18:46:44 INFO - 2015-11-16 18:46:44,993 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:46:45 INFO - 2015-11-16 18:46:45,045 DEBUG : process_Request line: kraken 1543.40 graph.html#tests=[[232,132,43]] 18:46:45 INFO - 2015-11-16 18:46:45,045 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:46:45 INFO - 2015-11-16 18:46:45,090 DEBUG : process_Request line: v8_7 21294.00 graph.html#tests=[[230,132,43]] 18:46:45 INFO - 2015-11-16 18:46:45,091 INFO : javascript benchmark 18:46:45 INFO - 2015-11-16 18:46:45,094 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [337.47522602353337, 337.9650736387243, 338.9525466434698, 339.0, 342.5581000509343, 11032.172587055962, 11330.830037549444, 14960.102393856376, 15595.376184952602, 15872.920635396822, 10103.444310562934, 10168.949155254231, 10325.741856453593, 10403.219758518104, 10406.791864162713, 4235.258829704797, 4358.716683415583, 4364.9781751091205, 4366.323219900921, 4368.519462859099, 4317.373980772802, 4326.048269380732, 4338.175746608134, 4664.277037059262, 4773.737444440554, 4520.208963431386, 4643.791029403685, 4654.0, 4709.976450117744, 4713.033828065256, 4558.133954548642, 4612.146752850734, 4613.100445413146, 4616.769161541926, 4637.258038713807, 3879.3405121129476, 3929.6659783918403, 3982.5021872265966, 4004.0990777075217, 4008.2584721826556, 11394.37330946806, 12294.75410491785, 12375.814362784566, 12635.368231588383, 12647.936760316139, 1663.8419350161837, 1672.2391311953154, 1685.148999755128, 1706.5392344067157, 2145.8927053647412, 8946.105389461067, 8951.73144805657, 9221.538923053888, 9255.861162082507, 9261.953690231574, 1560.9453669121526, 1639.6802623488425, 1656.080875114311, 1658.8341165883314, 1674.1294526846093, 52211.21683174755, 54909.1763623546, 55008.724956375365, 55163.17255241174, 55841.72079139578, 6695.230048544382, 6703.329667033355, 6726.461883049345, 6754.358335958076, 6799.966000169968, 7747.38020958322, 7787.143414224431, 7823.29590336861, 7827.921720782833, 7832.843343133105, 4774.498677638798, 4774.809007639656, 4778.713277203309, 4955.231939049453, 5035.974820125876, 4703.976480117578, 4716.056788642217, 4901.313816065754, 4975.278584605212, 4988.675736077216, 2993.0721476342405, 3024.6975302469577, 3033.9836154887917, 3040.6047213862057, 3052.862621182052, 1077.3697387028676, 1087.124864484082, 1089.2810744908322, 1100.1913593508764, 1136.9829452558217, 362.59389483778335, 363.4566323346561, 413.3489753638032, 434.9521552629208, 439.9516053234142, 9732.270079744048, 9763.316567840184, 9870.555824987892, 9933.3543319684, 9949.701508954742, 385.6490593559847, 390.04050036908956, 391.23513531046734, 396.38560231640844, 409.3552654569066, 5320.802819365612, 5356.46435356469, 5385.380681221632, 5394.0, 5447.53695935842, 478475.0, 493312.0, 513753.0, 516116.0, 525892.0, 66909.0, 70140.6492967532, 70595.64702176559, 70679.64660176769, 71257.64371178215, 486.4357345479227, 492.19526074867133, 494.6710437558983, 498.89523200127655, 498.9251612258118, 10681.985211404904, 10718.678439646823, 10743.08683761889, 10776.29954052984, 10779.73050673708, 32943.83528082344, 33237.833810830794, 33870.30648467616, 34230.65769342275, 34991.0, 43019.56980430281, 44479.33281000852, 45412.54587454083, 45437.77281113705, 45874.082518348776, 6391.073294372383, 6412.9679351602945, 6419.775307864389, 6442.033694945796, 6453.645049522133, 10718.820929697882, 11276.210665253353, 11296.6046188383, 11391.145664075393, 11463.025642820454, 9615.278854085831, 9985.350952188084, 10045.799084018425, 10090.293679442368, 10366.948165259126, 9446.905530944878, 9525.761855953378, 9532.380395274562, 9596.76008099803, 9780.853287200556, 2376.702912135983, 6930.896036559355, 8956.28349732033, 9930.553125109243, 10580.523876425734, 6436.420722135031, 6455.354464553507, 6516.380943810331, 6518.934810651833, 6554.672266386567, 9373.390729602554, 9845.458499782295, 10009.5495702695, 10199.949000254952, 10401.68794936153], "dojo.html": [2701.702812690604, 2742.9725702742967, 2778.374865655228, 2784.4570308789794, 2791.0789439484965, 4729.621630269578, 4810.254410566364, 4850.757462126897, 4896.461389247189, 4898.926516102257, 4741.051789642068, 4769.90460190796, 4809.350737650416, 4830.830920917769, 4880.4143502779625, 4375.343698445243, 4433.866983990485, 4466.531014243506, 4479.3952816369865, 4479.529649386816, 4485.215087359716, 4560.543945605429, 4599.563041511068, 4614.976925115369, 4626.768661566925, 4249.915001699979, 4337.262665346899, 4360.4331436913, 4472.463304403476, 4475.48531918827, 4482.305242687388, 4492.595666390008, 4496.662750293708, 4507.549245075499, 4540.0, 4466.9106617867465, 4477.395551600557, 4479.3281007848755, 4489.528599497038, 4526.23054080807, 4594.310853371988, 4603.5166307537565, 4673.789679464398, 4764.927891224482, 4799.568038876518, 5221.738913054332, 5238.05714971305, 5240.895182096337, 5256.185291279858, 5285.286486324336, 5040.6471546991725, 5263.236830659571, 5268.657537260104, 5268.947310526884, 5271.683698978035, 4733.0533893221145, 4794.2089555223, 4801.279808028754, 4823.879403014917, 4851.830185943475, 5326.174442961347, 5342.439043900412, 5367.194920761917, 5376.892462150813, 5421.593380496479, 4834.154023045953, 4930.901381972412, 5108.514691104339, 5142.845714628567, 5145.202493613496, 5033.5721463676, 5126.15418455958, 5133.076046311699, 5155.61332900034, 5198.2722418861385, 5179.896402071938, 5193.246979187997, 5215.191645294985, 5223.503767142115, 5257.631965762436, 4920.655554111249, 5012.548870601663, 5060.696358218519, 5172.172452407597, 5193.350831146106, 4281.05816720321, 4282.250606143913, 4305.870823875289, 4328.394024836525, 4329.09089091288, 3721.0697325668584, 3732.9813350933073, 3740.5137332146646, 3742.5883152853166, 3760.1539653578275, 4333.111712099075, 4393.912121757547, 4450.688451808407, 4501.797419116082, 4519.435070616173, 5200.63595548308, 5244.501772331622, 5249.816256431007, 5257.97666341855, 5270.10408230594, 4507.571780680895, 4516.864494065183, 4525.0497395546645, 4530.093981203772, 4563.406757121553, 4429.11417716458, 4512.142692888341, 4551.112533056023, 4619.4687610925175, 4654.2785868190485, 4960.801567937314, 4965.35450391454, 4983.6760610560195, 4986.077575648516, 5025.974870125699, 4988.27669987857, 5260.2898608688865, 5271.630985831109, 5272.0, 5291.479820627803, 4861.635377346643, 4873.926891096708, 4873.975630121827, 4882.170031094794, 4886.144924638245, 5182.274481572507, 5182.922256166085, 5187.221916712523, 5190.792368305226, 5206.479352064915, 5252.579793616425, 5261.579073674174, 5272.78908843642, 5284.339457567804, 5304.681719096867, 4818.10864989978, 4914.852554423373, 4923.6307276955085, 5051.570616497492, 5081.5426611605135, 5024.246363045572, 5025.6482046256415, 5038.672486288379, 5065.645404821627, 5107.565856902205, 4928.67963582366, 4955.0, 4960.156773348612, 4966.553010228952, 4990.276409920614, 4836.226203807374, 4940.60475161979, 4958.082754690394, 5030.874228144326, 5053.065182941021, 4981.701097934136, 4998.625103117208, 5007.173816320412, 5008.724520151427, 5029.5221953914315], "mootools.html": [1500.2048914075544, 1613.1530946253217, 1664.619593980608, 1670.4070055130423, 1680.9914051569067, 5950.10748387742, 6095.51235901128, 6972.895406568906, 7044.18991815942, 7067.611281379522, 6774.254831968479, 6892.758753443631, 6921.480888933325, 6927.515073944826, 6967.1291088613925, 2043.2848503023934, 2078.2933802507146, 2078.5738923520717, 2080.5942841145984, 2084.0309256195865, 2073.3572592496375, 2083.4166433398673, 2094.8114669679726, 2145.3992881993067, 2152.988095595068, 2034.3286715383888, 2036.378904434147, 2048.5185981294385, 2054.6917962305697, 2055.619710353589, 2039.9082041308102, 2062.185436752482, 2063.226290141197, 2063.329417939176, 2063.6491796394575, 2050.5283784729595, 2082.5834833033455, 2084.1559168536614, 2086.13425428447, 2091.393495886191, 7082.716691332341, 7168.498205125643, 7174.605396703179, 7176.174739904925, 7188.856222875514, 4145.0880806222585, 4212.157568486315, 4219.008532994744, 4229.894252643709, 4232.195882782262, 2722.387462820869, 2798.2304866161967, 2801.929951751202, 2811.4939310924024, 2814.1979535832393, 1662.609286817597, 1686.2749017922288, 1692.213120898788, 1705.0707364486261, 1739.312971376312, 9466.29002824784, 9578.042195780436, 9625.133737963617, 9642.180414664692, 9665.855012174823, 3958.129211573449, 3969.0, 4087.6116768906904, 4087.795610219477, 4090.386442033659, 8517.872231916526, 8524.147585241426, 8536.914630853737, 8542.18849209324, 8544.2310192083, 4210.200061988213, 4218.367244913287, 4264.616184543406, 4265.97867010663, 4283.957160428418, 3814.084619691254, 3819.7899115548357, 3852.075501879529, 3892.8053597320586, 3905.902352441155, 3399.0822477931315, 3427.3145370925417, 3434.0, 3446.6897979181995, 3449.6377880322207, 1061.830107182847, 1080.060347497682, 1099.6865893220395, 1107.341132026443, 1114.409363037575, 799.8880156778056, 837.8701301298308, 1165.8484397028333, 1177.3406892140429, 1180.887815657511, 6828.180618325733, 6868.210155832044, 6892.276310987374, 6897.275786042494, 6898.896516552256, 967.1730670276812, 1034.0848349210853, 1040.8022475729588, 1041.1722680468895, 1084.0839490630406, 5374.032674118618, 5447.291852059207, 5462.426445223274, 5473.151661492475, 5477.589180811376, 7640.083190017233, 7664.425168112414, 8386.958065209757, 8416.831663366698, 8425.241728244488, 8284.585770711561, 8297.170282971654, 8328.750137495885, 8348.248657620721, 8435.24082832548, 6368.936310636927, 6382.680865956683, 6526.902096468557, 6540.411362977355, 6547.1161393211305, 6678.465722742266, 6687.498437617295, 6752.932470675427, 6781.830454238683, 6798.0, 7534.0, 7693.307602315818, 7699.461037727306, 7716.5755883426955, 7738.806529836799, 7718.6140692964, 7862.33170180541, 7893.565853878092, 7946.8807967881685, 7960.960195198987, 5813.128030795415, 5818.970905145447, 5834.27071616048, 5926.496247818984, 5964.31410387811, 6767.492438067066, 6825.078614386995, 6826.283240259701, 6845.897311540231, 6849.1096157499205, 6311.747530098744, 6371.203599550056, 6417.2299324081405, 6431.158970179692, 6497.967510162419, 5882.5293976482635, 5890.293164820077, 5944.395013346286, 5962.612430192024, 6005.2793664758765, 6362.713677884413, 6382.457491113308, 6388.009858471944, 6408.487321014214, 6412.9679351602945, 5769.567282453749, 5772.0, 5776.277965254343, 5793.0, 5806.44838740319, 5948.405159484017, 5994.970025149846, 6066.332703402711, 6074.969625151846, 6097.085437184458], "ext.html": [564.0354992962032, 571.34010218198, 572.8828783871451, 577.367782278405, 583.9737211825468, 33698.15754606136, 34482.48276275858, 34646.826765866135, 34682.306353872904, 34693.653063469355, 38524.80737596308, 39287.0, 39379.606203937954, 39388.212235755265, 39414.80292598533, 7994.080680721733, 8132.796680083015, 8142.0, 8147.388945829057, 8148.7147949821765, 7919.56442395668, 8032.839343213162, 8036.27673509384, 8037.598120094001, 8065.879011814827, 7952.681892724313, 7959.761207163794, 7999.0, 8035.919640803605, 8040.437169398145, 7990.360771138295, 7994.280514753671, 8032.277095061472, 8041.798955026142, 8080.71717489885, 7836.294733473957, 7994.920050799534, 7998.800029999238, 8003.879941800819, 8013.759587212393, 36860.63139368599, 36898.0, 37096.07259818526, 37201.25597488062, 37249.25501489955, 2821.5767634854733, 2993.536001919684, 3127.218195451137, 3140.1906473024724, 3344.0, 27998.44003119926, 28219.858900705363, 28272.575911361346, 28546.71453285482, 29033.854830725923, 2734.4531093781125, 2756.0767143007115, 2761.8342899426098, 2787.637607111083, 2818.8449635270053, 223976.0, 225835.0, 226908.0, 227388.0, 227418.0, 50452.0, 51702.741486292325, 53800.19299710508, 54708.452915471134, 55103.173452398245, 50803.23795143076, 50940.0, 51085.744571277646, 51283.0, 51291.66604170792, 11693.123015773852, 11733.120015998835, 11751.647450576496, 11792.115591330685, 11794.469248883821, 9017.504037278013, 9038.367314288069, 9046.502442365732, 9049.321300902458, 9054.411463254868, 18706.90646546786, 19356.806431935784, 19365.612687746165, 19512.853586105517, 19530.414087577396, 6967.581945083311, 7102.644867756591, 7152.642367881585, 7254.492185547067, 7271.67277472515, 779.174075479993, 848.7284069097952, 879.463527248378, 939.4410325856105, 947.8056998315329, 25649.42477392951, 25978.480430391286, 26518.867405663234, 26565.601515977276, 26584.867075664497, 860.7116615933608, 915.8305713443034, 995.5569771451779, 1004.2769206171545, 1007.3955626624113, 13499.392527336096, 13692.863071369358, 13861.0, 13933.860661393459, 13951.58145255644, 279719.0, 282963.0, 284551.0, 284711.0, 284866.0, 45341.77329113333, 45357.77321113373, 45592.08815823665, 45749.0, 45838.31242531365, 1150.827375893606, 1177.5996161305197, 1182.6511179201984, 1185.9940700296443, 1191.5114802930757, 25289.873550632128, 25875.0, 25938.481230375663, 25943.740562594132, 25947.35131621649, 40037.39943900902, 40262.39606405848, 40578.39132413075, 40770.592294076676, 40789.38815917823, 269544.0, 273067.0, 273343.0, 273560.0, 274367.0, 28487.85756071289, 28778.856105720173, 28957.131286061453, 28963.85518072396, 29716.40567188601, 36456.27087458289, 36973.44539831851, 37260.441093384165, 37644.62355376411, 37814.810925945196, 31939.36121277515, 32036.19909502188, 32477.35045299128, 33371.83314083414, 33443.49834752432, 31760.841195793873, 32335.0, 32509.512357315132, 33235.50146747849, 35048.824755876056, 32191.0, 32360.352792943537, 32396.352072957936, 32714.182145446553, 33676.66323336833, 27846.3038424041, 28702.0, 28841.85579072091, 29607.0, 29791.27609048869, 21944.890275549158, 22098.77901220967, 22309.888450557642, 22406.88796556007, 23565.175218867258], "prototype.html": [286.07882617970137, 294.317184132812, 298.2231287496072, 299.5282430172479, 300.03837700170953, 5465.945340546598, 5599.412061733516, 5617.213590097384, 5691.345495268046, 5729.828105156842, 5605.495505404513, 5608.579356548265, 5627.887442251153, 5631.099024156136, 5652.802151924683, 4298.46269216348, 4298.484181898177, 4310.827566897328, 4326.09152078064, 4326.394304797331, 4320.135972805436, 4321.395004699345, 4321.762303073329, 4323.805428755698, 4331.4802223733195, 4080.9591904081026, 4254.298040823261, 4255.489341279051, 4272.0, 4274.551172126929, 4217.0511634881905, 4223.324268117102, 4248.299030659938, 4252.808623611945, 4262.9147417051645, 3652.579953305351, 3654.3604869148057, 3654.4152935530456, 3656.213914008501, 3656.597774244831, 5405.135178371442, 5408.378036525811, 5420.0, 5426.728663566845, 5433.429489903582, 4467.329900514948, 4698.436187657503, 4848.612111031144, 4872.537108974641, 4894.36373271476, 5607.0, 5706.9714651426475, 5834.64992100471, 5892.23400957877, 5896.882062358729, 3953.1105501262273, 3955.0507878109333, 3957.426173204898, 3959.762414255154, 3961.009747563109, 6026.276846778414, 6111.847203819895, 6140.140380346755, 6215.595986260879, 6231.127642130105, 4065.5527891931865, 4084.6528045116497, 4086.387041943732, 4089.8773036808943, 4100.302948498763, 4155.812988415468, 4156.709030367845, 4157.97921010399, 4159.688023398257, 4166.104287578185, 4816.494268101869, 4831.855044348676, 4833.081714474239, 4833.806647734052, 4838.903221935612, 5635.859103522363, 5873.20711703923, 5875.324337701134, 5875.647461152259, 5892.292924849045, 1426.5506365494837, 1439.2803598200899, 1454.4400405843614, 1454.8908831837443, 1457.5117335692662, 933.1601558597181, 947.4173383369179, 954.3319676226669, 968.1528662420383, 969.1277849934974, 5056.797728090909, 5090.898182036339, 5108.872278193075, 5109.08036553424, 5119.0, 6061.54538409621, 6067.787627433018, 6079.088136779518, 6086.665233412116, 6093.6039157454625, 5065.341505604248, 5086.54221120101, 5098.2097774844215, 5110.718910459886, 5119.129747942859, 3188.3463889902514, 3271.787333823294, 3302.53764472974, 3307.5038744188564, 3311.089450401159, 5715.828525144252, 5724.484796368263, 5729.0, 5731.742071606787, 5737.110747834009, 6170.074488826712, 6183.783567575113, 6225.968870155711, 6241.34465881085, 6247.531435142291, 5645.915311270416, 5692.601517893708, 5696.3733989261145, 5711.343195532484, 5722.284714410699, 6142.0, 6194.318624951162, 6198.380161983766, 6208.410201030895, 6213.378662133931, 5997.70011499432, 6012.969935150471, 6033.668148251712, 6036.0644100164545, 6050.364711705383, 5790.623609465371, 5811.576163839886, 5816.389279125631, 5826.563007774519, 5848.0, 3963.603639636013, 4109.671226301948, 4144.730592511477, 4145.357469592218, 4152.730072545275, 5961.612495187799, 6151.815445536641, 6165.599236049642, 6169.537284703575, 6181.35095814933, 5861.0915308127305, 5948.762049517971, 5964.642121472725, 5965.940340596712, 5973.761049557969, 5892.9116063258225, 5921.2006379138265, 5938.970305148447, 5947.434993675767, 5952.791652292322, 5661.433856614306, 5788.681622510802, 5798.913016304843, 5800.854978625399, 5835.124731290341, 5974.910376344272, 5988.401159883977, 5991.281046274475, 5992.820215393545, 5993.041113422006, 5782.392848750989, 5807.912881306699, 5820.097884827689, 5828.6502809831545, 5849.590528662953], "yui.html": [639.1209843061396, 663.0518358746996, 775.52692857357, 780.3562061299426, 794.6821271491405, 11649.068074554036, 11789.0, 11814.17300788945, 11844.82232766508, 11903.64289071327, 10625.78748425031, 10656.573737050508, 10708.036276735093, 10708.518116684769, 10810.513526891289, 730.1202051527896, 745.165414735497, 746.3842330077681, 746.4252525555319, 762.6491813765647, 739.970401183952, 744.7579536650583, 747.2079595628651, 748.711745977797, 749.0786332810646, 776.5263189454429, 778.3928535742131, 778.4084096086958, 781.2539025230919, 782.8160382310152, 773.8529679360931, 774.175503089211, 775.8448310337955, 778.7819410564995, 779.0, 565.1522715926111, 566.9036263835158, 567.3135506037659, 567.3730527766841, 567.4127278266974, 11765.117616178735, 11805.173637845353, 11807.58673446434, 11814.29114253139, 11826.11304152192, 8410.95904051138, 8892.73321800347, 8973.685920992799, 9514.143727064597, 9619.807603847954, 8423.663053477854, 8513.542460608056, 8740.21338079576, 9331.066893310683, 9349.719508414759, 2755.3938133610573, 2824.3927555575447, 2825.9717402825913, 2841.7158284171624, 2866.1831378057364, 38644.61355386438, 39014.609853901384, 39029.0, 39039.8048009761, 39308.41037384442, 6567.1462709848365, 6814.420774234147, 6838.21360543534, 6849.48628852838, 6913.3777959983845, 10638.627648032436, 10646.574137034431, 10648.78702425947, 10653.360798352123, 10682.732931676615, 5412.756425960842, 5508.14623733322, 5570.2201691762375, 5576.693281869536, 5636.210930469738, 3442.4319987202334, 3447.9655203447646, 3581.4448760442174, 3608.585012723518, 3637.636236376341, 2353.7410884802657, 2384.701912260967, 2388.379021454434, 2392.6411038344386, 2392.8923198455764, 364.54345624737897, 368.34067020033837, 368.85798967397744, 373.6450372146417, 379.50095624254016, 403.35060552510436, 463.5827755020441, 466.4332835604757, 469.0969882975259, 544.964577302474, 6873.621950792654, 6982.511224214256, 7166.247544007804, 7173.175084865203, 7184.317489838457, 371.5411466838452, 414.9813258403379, 554.4594020829659, 556.262951589138, 574.5690731951037, 3266.6080070391704, 3368.781029233092, 3493.7729047611824, 3527.400341941876, 3546.078019714893, 48365.0, 49095.26357104646, 49789.751051245235, 50043.0, 50186.0, 44540.55459445429, 44826.55173448289, 44935.55064449379, 45421.545784542395, 45460.0, 39431.60568394279, 41186.1762764743, 41468.37797433041, 41564.58435415668, 42521.936951577074, 6249.7500099997305, 6297.811065668037, 6464.806055818145, 6518.641474718936, 7583.544987300779, 30383.240418989702, 30688.0, 31702.524462132624, 31945.0, 32186.678133218367, 39795.60204397919, 40028.59971400365, 40398.19203615852, 40543.0, 40595.188096238504, 6889.414399776075, 6945.409640180641, 7052.541584796972, 7073.787786366417, 7102.07673002527, 10579.8942010582, 10586.629467968583, 10922.563097476012, 11054.170937179582, 11200.663980080612, 9238.122378374044, 9320.394174378644, 9389.953050234704, 9705.514724263618, 10152.796944061225, 9192.816143676955, 9632.630311234165, 9800.509974501103, 9836.754081148028, 10232.386056836614, 8573.0, 8845.911540884767, 9038.09619038091, 9296.58165382573, 9400.106989835955, 8079.313258373104, 8567.785805354915, 8782.165694259034, 8836.779080523038, 8926.241269492166, 7414.369778568882, 7992.280694737501, 8044.517328960281, 8115.634796434057, 8466.830663386821]}, "summary": {"lowerIsBetter": false, "suite": 5988.209064010862, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6265.408495253672, "unit": "ms", "value": 6265.408495253672}, "dojo.html": {"lowerIsBetter": false, "filtered": 4751.411467333675, "unit": "ms", "value": 4751.411467333675}, "mootools.html": {"lowerIsBetter": false, "filtered": 4163.725536848227, "unit": "ms", "value": 4163.725536848227}, "ext.html": {"lowerIsBetter": false, "filtered": 16506.516486774402, "unit": "ms", "value": 16506.516486774402}, "prototype.html": {"lowerIsBetter": false, "filtered": 4367.085666158347, "unit": "ms", "value": 4367.085666158347}, "yui.html": {"lowerIsBetter": false, "filtered": 5159.892690162842, "unit": "ms", "value": 5159.892690162842}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-024.e"}, "testrun": {"date": 1447727188, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116173404", "branch": "Fx-Team-Non-PGO", "revision": "ffdc7f22130425020f5d648ef99c10b947541659"}}, {"talos_counters": {}, "results": {"audio-dft": [164.0, 165.0, 163.0, 162.0, 162.0, 165.0, 169.0, 162.0, 169.0, 165.0], "ai-astar": [112.0, 106.0, 115.0, 112.0, 111.0, 124.0, 112.0, 111.0, 113.0, 113.0], "imaging-gaussian-blur": [110.0, 110.0, 109.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0], "audio-beat-detection": [158.0, 130.0, 154.0, 178.0, 130.0, 158.0, 164.0, 133.0, 163.0, 142.0], "json-stringify-tinderbox": [69.0, 69.0, 69.0, 69.0, 69.0, 70.0, 70.0, 69.0, 69.0, 73.0], "stanford-crypto-pbkdf2": [155.0, 154.0, 167.0, 142.0, 149.0, 151.0, 151.0, 153.0, 157.0, 149.0], "json-parse-financial": [72.0, 72.0, 74.0, 74.0, 76.0, 72.0, 74.0, 74.0, 74.0, 73.0], "stanford-crypto-sha256-iterative": [72.0, 70.0, 73.0, 74.0, 72.0, 70.0, 69.0, 73.0, 70.0, 72.0], "audio-fft": [74.0, 72.0, 73.0, 73.0, 73.0, 73.0, 138.0, 73.0, 73.0, 79.0], "imaging-darkroom": [149.0, 150.0, 149.0, 148.0, 149.0, 149.0, 157.0, 150.0, 151.0, 150.0], "stanford-crypto-ccm": [128.0, 122.0, 120.0, 123.0, 122.0, 121.0, 123.0, 131.0, 127.0, 121.0], "audio-oscillator": [92.0, 92.0, 135.0, 92.0, 91.0, 92.0, 126.0, 92.0, 92.0, 129.0], "stanford-crypto-aes": [82.0, 83.0, 85.0, 84.0, 84.0, 93.0, 84.0, 83.0, 83.0, 82.0], "imaging-desaturate": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 97.0, 95.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1543.3999999999996, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.1, "unit": "ms", "value": 80.1}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 152.8, "unit": "ms", "value": 152.8}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 151.0, "unit": "ms", "value": 151.0}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 123.8, "unit": "ms", "value": 123.8}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 150.2, "unit": "ms", "value": 150.2}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 73.5, "unit": "ms", "value": 73.5}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.3, "unit": "ms", "value": 103.3}, "ai-astar": {"lowerIsBetter": true, "filtered": 112.9, "unit": "ms", "value": 112.9}, "audio-dft": {"lowerIsBetter": true, "filtered": 164.6, "unit": "ms", "value": 164.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 71.5, "unit": "ms", "value": 71.5}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.6, "unit": "ms", "value": 69.6}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.0, "unit": "ms", "value": 110.0}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 84.3, "unit": "ms", "value": 84.3}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.8, "unit": "ms", "value": 95.8}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-024.e"}, "testrun": {"date": 1447727188, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116173404", "branch": "Fx-Team-Non-PGO", "revision": "ffdc7f22130425020f5d648ef99c10b947541659"}}, {"talos_counters": {}, "results": {"DeltaBlue": [190.8761213972132], "Encrypt": [279.17364600781684], "NavierStokes": [4830.917874396136], "Decrypt": [5035.175879396985], "Splay": [610.8075288403157], "Richards": [163.96130513198884], "RegExp": [25666.666666666668], "Earley": [734.7538574577517], "Boyer": [12432.098765432098], "RayTrace": [1068.3760683760684]}, "summary": {"lowerIsBetter": false, "suite": 21294.003241177958, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 346.39220200000005, "unit": "score", "value": 346.39220200000005}, "Encrypt": {"lowerIsBetter": false, "filtered": 953.4603419999996, "unit": "score", "value": 953.4603419999996}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.864290419161705, "unit": "score", "value": 52.864290419161705}, "Splay": {"lowerIsBetter": false, "filtered": 133.41518588469185, "unit": "score", "value": 133.41518588469185}, "RegExp": {"lowerIsBetter": false, "filtered": 35.49292207792205, "unit": "score", "value": 35.49292207792205}, "Richards": {"lowerIsBetter": false, "filtered": 215.306898, "unit": "score", "value": 215.306898}, "Earley": {"lowerIsBetter": false, "filtered": 907.0561430000002, "unit": "score", "value": 907.0561430000002}, "Boyer": {"lowerIsBetter": false, "filtered": 53.608245283018846, "unit": "score", "value": 53.608245283018846}, "RayTrace": {"lowerIsBetter": false, "filtered": 692.6297040000002, "unit": "score", "value": 692.6297040000002}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-024.e"}, "testrun": {"date": 1447727188, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116173404", "branch": "Fx-Team-Non-PGO", "revision": "ffdc7f22130425020f5d648ef99c10b947541659"}}] 18:46:45 INFO - RETURN: dromaeo_css: 5988.21 18:46:45 INFO - RETURN: kraken: 1543.40 18:46:45 INFO - RETURN: v8_7: 21294.00 18:46:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21294.00"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1543.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "5988.21"}}} 18:46:45 INFO - Return code: 0 18:46:45 INFO - # TBPL SUCCESS # 18:46:45 INFO - Running post-action listener: _resource_record_post_action 18:46:45 INFO - Running post-run listener: _resource_record_post_run 18:46:46 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 4096; Write bytes: 513998848; Read time: 12; Write time: 414472 18:46:46 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 136736768; Read time: 0; Write time: 165124 18:46:46 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 0; Write bytes: 377262080; Read time: 0; Write time: 249348 18:46:46 INFO - Running post-run listener: _upload_blobber_files 18:46:46 INFO - Blob upload gear active. 18:46:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:46:46 INFO - Copying logs to upload dir... 18:46:46 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1257.934298 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-16 18:46:46.254265) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 18:46:46.257678) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/U2le5VeASl2xS9sFPc75KA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010210 build_url: 'https://queue.taskcluster.net/v1/task/U2le5VeASl2xS9sFPc75KA/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-16 18:46:46.310605) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:46:46.310973) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1447727145.762198-1884515727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:46:46.361143) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 18:46:46.361497) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 18:46:46.361833) ========= ========= Total master_lag: 0.22 =========