builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1448315145.18 results: success (0) buildid: 20151123115619 builduid: faee03c2fc7f4b328e117972797ad538 revision: 8705b0a58e1abd8a4d8f23e5d83caeda48bdbfe2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 13:45:45.176006) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 13:45:45.176468) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 13:45:45.176756) ========= 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=61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005618 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 13:45:45.193460) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 13:45:45.193800) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 13:45:45.204299) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:45:45.204789) ========= 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=61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004224 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:45:45.254005) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 13:45:45.254310) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 13:45:45.254667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:45:45.254964) ========= 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=61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 13:45:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-11-23 13:45:45 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150236 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:45:45.417526) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:45:45.417860) ========= 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=61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014701 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:45:45.468359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 13:45:45.468801) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 8705b0a58e1abd8a4d8f23e5d83caeda48bdbfe2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 8705b0a58e1abd8a4d8f23e5d83caeda48bdbfe2 --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=61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 13:45:45,821 truncating revision to first 12 chars 2015-11-23 13:45:45,821 Setting DEBUG logging. 2015-11-23 13:45:45,821 attempt 1/10 2015-11-23 13:45:45,821 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/8705b0a58e1a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 13:45:46,554 unpacking tar archive at: b2g-inbound-8705b0a58e1a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.034002 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 13:45:46.517780) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 13:45:46.518283) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 13:45:46.767870) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 13:45:46.768261) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 13:45:46.768692) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-23 13:45:46.768976) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-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=61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:45:47 INFO - MultiFileLogger online at 20151123 13:45:47 in /builds/slave/test 13:45:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 13:45:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:45:47 INFO - {'append_to_log': False, 13:45:47 INFO - 'base_work_dir': '/builds/slave/test', 13:45:47 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 13:45:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:45:47 INFO - 'branch': 'B2G-Inbound-Non-PGO', 13:45:47 INFO - 'buildbot_json_path': 'buildprops.json', 13:45:47 INFO - 'config_files': ('talos/linux_config.py',), 13:45:47 INFO - 'default_actions': ('clobber', 13:45:47 INFO - 'read-buildbot-config', 13:45:47 INFO - 'download-and-extract', 13:45:47 INFO - 'populate-webroot', 13:45:47 INFO - 'create-virtualenv', 13:45:47 INFO - 'install', 13:45:47 INFO - 'run-tests'), 13:45:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:45:47 INFO - 'download_minidump_stackwalk': True, 13:45:47 INFO - 'download_symbols': 'ondemand', 13:45:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:45:47 INFO - 'tooltool.py': '/tools/tooltool.py', 13:45:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:45:47 INFO - '/tools/misc-python/virtualenv.py')}, 13:45:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:45:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:45:47 INFO - 'installer_path': 'installer.exe', 13:45:47 INFO - 'log_level': 'info', 13:45:47 INFO - 'log_name': 'talos', 13:45:47 INFO - 'log_to_console': True, 13:45:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:45:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:45:47 INFO - 'opt_config_files': (), 13:45:47 INFO - 'pip_index': False, 13:45:47 INFO - 'sps_profile': False, 13:45:47 INFO - 'sps_profile_interval': 0, 13:45:47 INFO - 'suite': 'dromaeojs', 13:45:47 INFO - 'system_bits': '64', 13:45:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:45:47 INFO - 'title': 'talos-linux64-ix-045', 13:45:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:45:47 INFO - 'use_talos_json': True, 13:45:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:45:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:45:47 INFO - 'work_dir': 'build'} 13:45:47 INFO - ##### 13:45:47 INFO - ##### Running clobber step. 13:45:47 INFO - ##### 13:45:47 INFO - Running pre-action listener: _resource_record_pre_action 13:45:47 INFO - Running main action method: clobber 13:45:47 INFO - rmtree: /builds/slave/test/build 13:45:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:45:48 INFO - Running post-action listener: _resource_record_post_action 13:45:48 INFO - ##### 13:45:48 INFO - ##### Running read-buildbot-config step. 13:45:48 INFO - ##### 13:45:48 INFO - Running pre-action listener: _resource_record_pre_action 13:45:48 INFO - Running main action method: read_buildbot_config 13:45:48 INFO - Using buildbot properties: 13:45:48 INFO - { 13:45:48 INFO - "properties": { 13:45:48 INFO - "buildnumber": 770, 13:45:48 INFO - "product": "firefox", 13:45:48 INFO - "script_repo_revision": "production", 13:45:48 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 13:45:48 INFO - "repository": "", 13:45:48 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 13:45:48 INFO - "buildid": "20151123115619", 13:45:48 INFO - "slavename": "talos-linux64-ix-045", 13:45:48 INFO - "pgo_build": "False", 13:45:48 INFO - "basedir": "/builds/slave/test", 13:45:48 INFO - "project": "", 13:45:48 INFO - "platform": "ubuntu64_hw", 13:45:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:45:48 INFO - "slavebuilddir": "test", 13:45:48 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 13:45:48 INFO - "branch": "b2g-inbound", 13:45:48 INFO - "repo_path": "integration/b2g-inbound", 13:45:48 INFO - "stage_platform": "linux64", 13:45:48 INFO - "builduid": "faee03c2fc7f4b328e117972797ad538", 13:45:48 INFO - "revision": "8705b0a58e1abd8a4d8f23e5d83caeda48bdbfe2" 13:45:48 INFO - }, 13:45:48 INFO - "sourcestamp": { 13:45:48 INFO - "repository": "", 13:45:48 INFO - "hasPatch": false, 13:45:48 INFO - "project": "", 13:45:48 INFO - "branch": "b2g-inbound-linux64-talos", 13:45:48 INFO - "changes": [ 13:45:48 INFO - { 13:45:48 INFO - "category": null, 13:45:48 INFO - "files": [ 13:45:48 INFO - { 13:45:48 INFO - "url": null, 13:45:48 INFO - "name": "https://queue.taskcluster.net/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 13:45:48 INFO - } 13:45:48 INFO - ], 13:45:48 INFO - "repository": "", 13:45:48 INFO - "rev": "8705b0a58e1abd8a4d8f23e5d83caeda48bdbfe2", 13:45:48 INFO - "who": "garndt@mozilla.com", 13:45:48 INFO - "when": 1448312978, 13:45:48 INFO - "number": 6696806, 13:45:48 INFO - "comments": "Bug 1226603 - Include scope for gecko-decision cache r=jonasfj", 13:45:48 INFO - "project": "", 13:45:48 INFO - "at": "Mon 23 Nov 2015 13:09:38", 13:45:48 INFO - "branch": "b2g-inbound-linux64-talos", 13:45:48 INFO - "revlink": "", 13:45:48 INFO - "properties": [ 13:45:48 INFO - [ 13:45:48 INFO - "buildid", 13:45:48 INFO - "20151123115619", 13:45:48 INFO - "Change" 13:45:48 INFO - ], 13:45:48 INFO - [ 13:45:48 INFO - "builduid", 13:45:48 INFO - "faee03c2fc7f4b328e117972797ad538", 13:45:48 INFO - "Change" 13:45:48 INFO - ], 13:45:48 INFO - [ 13:45:48 INFO - "pgo_build", 13:45:48 INFO - "False", 13:45:48 INFO - "Change" 13:45:48 INFO - ] 13:45:48 INFO - ], 13:45:48 INFO - "revision": "8705b0a58e1abd8a4d8f23e5d83caeda48bdbfe2" 13:45:48 INFO - } 13:45:48 INFO - ], 13:45:48 INFO - "revision": "8705b0a58e1abd8a4d8f23e5d83caeda48bdbfe2" 13:45:48 INFO - } 13:45:48 INFO - } 13:45:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 13:45:48 INFO - Running post-action listener: _resource_record_post_action 13:45:48 INFO - ##### 13:45:48 INFO - ##### Running download-and-extract step. 13:45:48 INFO - ##### 13:45:48 INFO - Running pre-action listener: _resource_record_pre_action 13:45:48 INFO - Running main action method: download_and_extract 13:45:48 INFO - mkdir: /builds/slave/test/build/tests 13:45: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')]} 13:45:48 INFO - https://queue.taskcluster.net/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:45:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/test_packages.json 13:45:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/test_packages.json 13:45:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:45:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:45:48 INFO - Downloaded 1302 bytes. 13:45:48 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:45:48 INFO - Using the following test package requirements: 13:45:48 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:45:48 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:45:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:45:48 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:45:48 INFO - u'jsshell-linux-x86_64.zip'], 13:45:48 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:45:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:45:48 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:45:48 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:45:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:45:48 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:45:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:45:48 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:45:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:45:48 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:45:48 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:45:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:45:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:45: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')]} 13:45:48 INFO - https://queue.taskcluster.net/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:45:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:45:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:45:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LuCeZxBaTqan9p46v13KiA/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 13:45:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LuCeZxBaTqan9p46v13KiA/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 13:45:50 INFO - Downloaded 21341474 bytes. 13:45: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 13:45:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:45: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 13:45:51 INFO - Return code: 0 13:45: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 13:45: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')]} 13:45:51 INFO - https://queue.taskcluster.net/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:45:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:45:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:45:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LuCeZxBaTqan9p46v13KiA/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 13:45:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LuCeZxBaTqan9p46v13KiA/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 13:45:52 INFO - Downloaded 21341474 bytes. 13:45: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 13:45:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:45: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 13:45:53 INFO - Return code: 0 13:45: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')]} 13:45:53 INFO - https://queue.taskcluster.net/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:45:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:45:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:45:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LuCeZxBaTqan9p46v13KiA/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 13:45:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LuCeZxBaTqan9p46v13KiA/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 13:45:55 INFO - Downloaded 11130997 bytes. 13:45:55 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 13:45:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:45:55 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 13:45:55 INFO - Return code: 0 13:45: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')]} 13:45:55 INFO - https://queue.taskcluster.net/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:45:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:45:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:45:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LuCeZxBaTqan9p46v13KiA/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 13:45:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LuCeZxBaTqan9p46v13KiA/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 13:45:57 INFO - Downloaded 56025261 bytes. 13:45:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:45:57 INFO - mkdir: /builds/slave/test/properties 13:45:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:45:57 INFO - Writing to file /builds/slave/test/properties/build_url 13:45:57 INFO - Contents: 13:45:57 INFO - build_url:https://queue.taskcluster.net/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:45:57 INFO - Running post-action listener: _resource_record_post_action 13:45:57 INFO - Running post-action listener: set_extra_try_arguments 13:45:57 INFO - ##### 13:45:57 INFO - ##### Running populate-webroot step. 13:45:57 INFO - ##### 13:45:57 INFO - Running pre-action listener: _resource_record_pre_action 13:45:57 INFO - Running main action method: populate_webroot 13:45:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:45:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:45:57 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 13:45:57 INFO - '../fennec_ids.txt'], 13:45:57 INFO - 'tests': ['tcheck2']}, 13:45:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:45:57 INFO - '--tppagecycles', 13:45:57 INFO - '7'], 13:45:57 INFO - 'tests': ['tsvgm']}}, 13:45:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:45:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:45:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:45:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:45:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:45:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:45:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:45:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:57 INFO - 'talos_options': ['--e10s'], 13:45:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:45:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:57 INFO - 'tests': ['damp', 'tps']}, 13:45:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:57 INFO - 'talos_options': ['--e10s'], 13:45:57 INFO - 'tests': ['damp', 'tps']}, 13:45:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:45:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:45:57 INFO - 'other': {'tests': ['a11yr', 13:45:57 INFO - 'ts_paint', 13:45:57 INFO - 'tpaint', 13:45:57 INFO - 'sessionrestore', 13:45:57 INFO - 'sessionrestore_no_auto_restore']}, 13:45:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:45:57 INFO - 'tests': ['a11yr', 13:45:57 INFO - 'ts_paint', 13:45:57 INFO - 'tpaint', 13:45:57 INFO - 'sessionrestore', 13:45:57 INFO - 'sessionrestore_no_auto_restore']}, 13:45:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:45:57 INFO - 'tests': ['a11yr', 13:45:57 INFO - 'ts_paint', 13:45:57 INFO - 'tpaint', 13:45:57 INFO - 'sessionrestore', 13:45:57 INFO - 'sessionrestore_no_auto_restore']}, 13:45:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:45:57 INFO - 'tests': ['a11yr', 13:45:57 INFO - 'ts_paint', 13:45:57 INFO - 'tpaint', 13:45:57 INFO - 'sessionrestore', 13:45:57 INFO - 'sessionrestore_no_auto_restore']}, 13:45:57 INFO - 'other_l64': {'tests': ['a11yr', 13:45:57 INFO - 'ts_paint', 13:45:57 INFO - 'tpaint', 13:45:57 INFO - 'sessionrestore', 13:45:57 INFO - 'sessionrestore_no_auto_restore']}, 13:45:57 INFO - 'other_nol64': {'tests': ['a11yr', 13:45:57 INFO - 'ts_paint', 13:45:57 INFO - 'tpaint', 13:45:57 INFO - 'sessionrestore', 13:45:57 INFO - 'sessionrestore_no_auto_restore']}, 13:45:57 INFO - 'svgr': {'tests': ['tsvgx', 13:45:57 INFO - 'tsvgr_opacity', 13:45:57 INFO - 'tart', 13:45:57 INFO - 'tscrollx', 13:45:57 INFO - 'cart']}, 13:45:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:45:57 INFO - 'tests': ['tsvgx', 13:45:57 INFO - 'tsvgr_opacity', 13:45:57 INFO - 'tart', 13:45:57 INFO - 'tscrollx', 13:45:57 INFO - 'cart']}, 13:45:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:57 INFO - 'tests': ['tp5o']}, 13:45:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:57 INFO - 'talos_options': ['--e10s'], 13:45:57 INFO - 'tests': ['tp5o']}, 13:45:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:57 INFO - 'talos_options': ['--xperf_path', 13:45:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:45:57 INFO - 'tests': ['tp5n']}, 13:45:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:57 INFO - 'talos_options': ['--e10s', 13:45:57 INFO - '--xperf_path', 13:45:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:45:57 INFO - 'tests': ['tp5n']}}, 13:45:57 INFO - 'talos.zip': {'path': '', 13:45:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:45:57 INFO - Running post-action listener: _resource_record_post_action 13:45:57 INFO - ##### 13:45:57 INFO - ##### Running create-virtualenv step. 13:45:57 INFO - ##### 13:45:57 INFO - Running pre-action listener: _resource_record_pre_action 13:45:57 INFO - Running main action method: create_virtualenv 13:45:57 INFO - Creating virtualenv /builds/slave/test/build/venv 13:45:57 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 13:45:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:45:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:45:57 INFO - Using real prefix '/usr' 13:45:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:45:58 INFO - Installing distribute.............................................................................................................................................................................................done. 13:46:00 INFO - Installing pip.................done. 13:46:00 INFO - Return code: 0 13:46:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:00 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 0x7fe413516c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13766c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1427900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146db70>, '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 0x14bedc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bf250>, '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': '61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653', '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 13:46:00 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 13:46:00 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 13:46:00 INFO - Using env: {'DISPLAY': ':0', 13:46:00 INFO - 'HOME': '/home/cltbld', 13:46:00 INFO - 'LANG': 'en_US.UTF-8', 13:46:00 INFO - 'LANGUAGE': 'en_US:en', 13:46:00 INFO - 'LOGNAME': 'cltbld', 13:46:00 INFO - 'MAIL': '/var/mail/cltbld', 13:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:00 INFO - 'MOZ_NO_REMOTE': '1', 13:46:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:00 INFO - 'NO_EM_RESTART': '1', 13:46:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:46:00 INFO - 'PWD': '/builds/slave/test', 13:46:00 INFO - 'SHELL': '/bin/bash', 13:46:00 INFO - 'SHLVL': '1', 13:46:00 INFO - 'TERM': 'linux', 13:46:00 INFO - 'TMOUT': '86400', 13:46:00 INFO - 'USER': 'cltbld', 13:46:00 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653', 13:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:00 INFO - '_': '/tools/buildbot/bin/python'} 13:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:00 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 13:46:00 INFO - Cleaning up... 13:46:00 INFO - Return code: 0 13:46:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:00 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 0x7fe413516c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13766c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1427900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146db70>, '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 0x14bedc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bf250>, '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': '61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653', '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 13:46:00 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 13:46:00 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 13:46:00 INFO - Using env: {'DISPLAY': ':0', 13:46:00 INFO - 'HOME': '/home/cltbld', 13:46:00 INFO - 'LANG': 'en_US.UTF-8', 13:46:00 INFO - 'LANGUAGE': 'en_US:en', 13:46:00 INFO - 'LOGNAME': 'cltbld', 13:46:00 INFO - 'MAIL': '/var/mail/cltbld', 13:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:00 INFO - 'MOZ_NO_REMOTE': '1', 13:46:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:00 INFO - 'NO_EM_RESTART': '1', 13:46:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:46:00 INFO - 'PWD': '/builds/slave/test', 13:46:00 INFO - 'SHELL': '/bin/bash', 13:46:00 INFO - 'SHLVL': '1', 13:46:00 INFO - 'TERM': 'linux', 13:46:00 INFO - 'TMOUT': '86400', 13:46:00 INFO - 'USER': 'cltbld', 13:46:00 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653', 13:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:00 INFO - '_': '/tools/buildbot/bin/python'} 13:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:00 INFO - Downloading/unpacking psutil>=0.7.1 13:46:00 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 13:46:00 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 13:46:00 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 13:46:00 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 13:46:00 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 13:46:00 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 13:46:02 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 13:46:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:46:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:46:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:46:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:46:02 INFO - Installing collected packages: psutil 13:46:02 INFO - Running setup.py install for psutil 13:46:02 INFO - building 'psutil._psutil_linux' extension 13:46:02 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 13:46:02 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 13:46:02 INFO - building 'psutil._psutil_posix' extension 13:46:02 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 13:46:02 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 13:46:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:46:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:46:02 INFO - Successfully installed psutil 13:46:02 INFO - Cleaning up... 13:46:03 INFO - Return code: 0 13:46:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:46: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')]} 13:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46: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')]} 13:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46: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', '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 0x7fe413516c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13766c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1427900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146db70>, '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 0x14bedc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bf250>, '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': '61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653', '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 13:46: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:46: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 mozsystemmonitor==0.0.0 13:46:03 INFO - Using env: {'DISPLAY': ':0', 13:46:03 INFO - 'HOME': '/home/cltbld', 13:46:03 INFO - 'LANG': 'en_US.UTF-8', 13:46:03 INFO - 'LANGUAGE': 'en_US:en', 13:46:03 INFO - 'LOGNAME': 'cltbld', 13:46:03 INFO - 'MAIL': '/var/mail/cltbld', 13:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:03 INFO - 'MOZ_NO_REMOTE': '1', 13:46:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:03 INFO - 'NO_EM_RESTART': '1', 13:46:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:46:03 INFO - 'PWD': '/builds/slave/test', 13:46:03 INFO - 'SHELL': '/bin/bash', 13:46:03 INFO - 'SHLVL': '1', 13:46:03 INFO - 'TERM': 'linux', 13:46:03 INFO - 'TMOUT': '86400', 13:46:03 INFO - 'USER': 'cltbld', 13:46:03 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653', 13:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:03 INFO - '_': '/tools/buildbot/bin/python'} 13:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:46:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:46:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:46:04 INFO - Installing collected packages: mozsystemmonitor 13:46:04 INFO - Running setup.py install for mozsystemmonitor 13:46:05 INFO - Successfully installed mozsystemmonitor 13:46:05 INFO - Cleaning up... 13:46:05 INFO - Return code: 0 13:46:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:05 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 0x7fe413516c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13766c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1427900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146db70>, '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 0x14bedc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bf250>, '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': '61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653', '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 13:46:05 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 13:46:05 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 13:46:05 INFO - Using env: {'DISPLAY': ':0', 13:46:05 INFO - 'HOME': '/home/cltbld', 13:46:05 INFO - 'LANG': 'en_US.UTF-8', 13:46:05 INFO - 'LANGUAGE': 'en_US:en', 13:46:05 INFO - 'LOGNAME': 'cltbld', 13:46:05 INFO - 'MAIL': '/var/mail/cltbld', 13:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:05 INFO - 'MOZ_NO_REMOTE': '1', 13:46:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:05 INFO - 'NO_EM_RESTART': '1', 13:46:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:46:05 INFO - 'PWD': '/builds/slave/test', 13:46:05 INFO - 'SHELL': '/bin/bash', 13:46:05 INFO - 'SHLVL': '1', 13:46:05 INFO - 'TERM': 'linux', 13:46:05 INFO - 'TMOUT': '86400', 13:46:05 INFO - 'USER': 'cltbld', 13:46:05 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653', 13:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:05 INFO - '_': '/tools/buildbot/bin/python'} 13:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:05 INFO - Downloading/unpacking blobuploader==1.2.4 13:46: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 13:46: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 13:46: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 13:46: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 13:46: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 13:46: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 13:46:07 INFO - Downloading blobuploader-1.2.4.tar.gz 13:46:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:46:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:46:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:46:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:46:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:07 INFO - Downloading docopt-0.6.1.tar.gz 13:46:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:46:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:46:07 INFO - Installing collected packages: blobuploader, requests, docopt 13:46:07 INFO - Running setup.py install for blobuploader 13:46:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:46:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:46:07 INFO - Running setup.py install for requests 13:46:08 INFO - Running setup.py install for docopt 13:46:08 INFO - Successfully installed blobuploader requests docopt 13:46:08 INFO - Cleaning up... 13:46:08 INFO - Return code: 0 13:46:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:46:08 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')]} 13:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:08 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')]} 13:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:08 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 0x7fe413516c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13766c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1427900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146db70>, '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 0x14bedc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bf250>, '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': '61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653', '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 13:46:08 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 13:46:08 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 13:46:08 INFO - Using env: {'DISPLAY': ':0', 13:46:08 INFO - 'HOME': '/home/cltbld', 13:46:08 INFO - 'LANG': 'en_US.UTF-8', 13:46:08 INFO - 'LANGUAGE': 'en_US:en', 13:46:08 INFO - 'LOGNAME': 'cltbld', 13:46:08 INFO - 'MAIL': '/var/mail/cltbld', 13:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:08 INFO - 'MOZ_NO_REMOTE': '1', 13:46:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:08 INFO - 'NO_EM_RESTART': '1', 13:46:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:46:08 INFO - 'PWD': '/builds/slave/test', 13:46:08 INFO - 'SHELL': '/bin/bash', 13:46:08 INFO - 'SHLVL': '1', 13:46:08 INFO - 'TERM': 'linux', 13:46:08 INFO - 'TMOUT': '86400', 13:46:08 INFO - 'USER': 'cltbld', 13:46:08 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653', 13:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:08 INFO - '_': '/tools/buildbot/bin/python'} 13:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:46:08 INFO - Running setup.py (path:/tmp/pip-3zWQth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:46:08 INFO - Running setup.py (path:/tmp/pip-gnFlqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:46:08 INFO - Running setup.py (path:/tmp/pip-UPRqf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:46:08 INFO - Running setup.py (path:/tmp/pip-vQE_Im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:46:08 INFO - Running setup.py (path:/tmp/pip-1GqViF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:46:08 INFO - Running setup.py (path:/tmp/pip-sr5pds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:46:09 INFO - Running setup.py (path:/tmp/pip-1oSdDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:46:09 INFO - Running setup.py (path:/tmp/pip-uxyIdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:46:09 INFO - Running setup.py (path:/tmp/pip-3T78wZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:46:09 INFO - Running setup.py (path:/tmp/pip-9vgjqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:46:09 INFO - Running setup.py (path:/tmp/pip-3Vb1Ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:46:09 INFO - Running setup.py (path:/tmp/pip-AsR3yb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:46:09 INFO - Running setup.py (path:/tmp/pip-QiaTTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:46:09 INFO - Running setup.py (path:/tmp/pip-fgjIPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:46:09 INFO - Running setup.py (path:/tmp/pip-WTQgQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:46:09 INFO - Running setup.py (path:/tmp/pip-suv059-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:46:09 INFO - Running setup.py (path:/tmp/pip-0DSyRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:46:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:46:09 INFO - Running setup.py install for manifestparser 13:46:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:46:09 INFO - Running setup.py install for mozcrash 13:46:10 INFO - Running setup.py install for mozdebug 13:46:10 INFO - Running setup.py install for mozdevice 13:46:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:46:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:46:10 INFO - Running setup.py install for mozfile 13:46:10 INFO - Running setup.py install for mozhttpd 13:46:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:46:10 INFO - Running setup.py install for mozinfo 13:46:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:46:10 INFO - Running setup.py install for mozInstall 13:46:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:46:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:46:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:46:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:46:10 INFO - Running setup.py install for mozleak 13:46:10 INFO - Running setup.py install for mozlog 13:46:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:46:10 INFO - Running setup.py install for moznetwork 13:46:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:46:10 INFO - Running setup.py install for mozprocess 13:46:11 INFO - Running setup.py install for mozprofile 13:46:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:46:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:46:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:46:11 INFO - Running setup.py install for mozrunner 13:46:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:46:11 INFO - Running setup.py install for mozscreenshot 13:46:11 INFO - Running setup.py install for moztest 13:46:11 INFO - Running setup.py install for mozversion 13:46:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:46:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:46:11 INFO - Cleaning up... 13:46:11 INFO - Return code: 0 13:46:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fe413516c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13766c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1427900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146db70>, '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 0x14bedc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bf250>, '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': '61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653', '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 13:46:11 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 13:46:11 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 13:46:11 INFO - Using env: {'DISPLAY': ':0', 13:46:11 INFO - 'HOME': '/home/cltbld', 13:46:11 INFO - 'LANG': 'en_US.UTF-8', 13:46:11 INFO - 'LANGUAGE': 'en_US:en', 13:46:11 INFO - 'LOGNAME': 'cltbld', 13:46:11 INFO - 'MAIL': '/var/mail/cltbld', 13:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:11 INFO - 'MOZ_NO_REMOTE': '1', 13:46:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:11 INFO - 'NO_EM_RESTART': '1', 13:46:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:46:11 INFO - 'PWD': '/builds/slave/test', 13:46:11 INFO - 'SHELL': '/bin/bash', 13:46:11 INFO - 'SHLVL': '1', 13:46:11 INFO - 'TERM': 'linux', 13:46:11 INFO - 'TMOUT': '86400', 13:46:11 INFO - 'USER': 'cltbld', 13:46:11 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653', 13:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:11 INFO - '_': '/tools/buildbot/bin/python'} 13:46:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:46:11 INFO - Running setup.py (path:/tmp/pip-6vO3iN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:46:11 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)) 13:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:46:11 INFO - Running setup.py (path:/tmp/pip-bylrhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:46:11 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)) 13:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:46:11 INFO - Running setup.py (path:/tmp/pip-OXBA6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:46:12 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)) 13:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:46:12 INFO - Running setup.py (path:/tmp/pip-zGDDjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:46:12 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)) 13:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:46:12 INFO - Running setup.py (path:/tmp/pip-ILvpAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:46:12 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)) 13:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:46:12 INFO - Running setup.py (path:/tmp/pip-QiL7F_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:46:12 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)) 13:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:46:12 INFO - Running setup.py (path:/tmp/pip-8TsJhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:46:12 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)) 13:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:46:12 INFO - Running setup.py (path:/tmp/pip-INGAzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:46:12 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)) 13:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:46:12 INFO - Running setup.py (path:/tmp/pip-927W8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:46:12 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)) 13:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:46:12 INFO - Running setup.py (path:/tmp/pip-h5DdKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:46:12 INFO - Running setup.py (path:/tmp/pip-NKWUx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:46:12 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)) 13:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:46:12 INFO - Running setup.py (path:/tmp/pip-LXKAEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:46:12 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)) 13:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:46:12 INFO - Running setup.py (path:/tmp/pip-aPogtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:46:12 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)) 13:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:46:12 INFO - Running setup.py (path:/tmp/pip-UnFdyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:46:12 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)) 13:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:46:12 INFO - Running setup.py (path:/tmp/pip-oYSgan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:46:12 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)) 13:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:46:12 INFO - Running setup.py (path:/tmp/pip-kBcFIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:46:12 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)) 13:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:46:12 INFO - Running setup.py (path:/tmp/pip-HlsuaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:46:13 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)) 13:46:13 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)) 13:46: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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:46:13 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)) 13:46:13 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)) 13:46:13 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)) 13:46:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:46:13 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 13:46:13 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 13:46:13 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 13:46:13 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 13:46:13 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 13:46:13 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 13:46:14 INFO - Downloading blessings-1.5.1.tar.gz 13:46:14 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 13:46:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:46:14 INFO - Installing collected packages: blessings 13:46:14 INFO - Running setup.py install for blessings 13:46:14 INFO - Successfully installed blessings 13:46:14 INFO - Cleaning up... 13:46:14 INFO - Return code: 0 13:46:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:46:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:46:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:46:15 INFO - Reading from file tmpfile_stdout 13:46:15 INFO - Current package versions: 13:46:15 INFO - argparse == 1.2.1 13:46:15 INFO - blessings == 1.5.1 13:46:15 INFO - blobuploader == 1.2.4 13:46:15 INFO - docopt == 0.6.1 13:46:15 INFO - manifestparser == 1.1 13:46:15 INFO - mozInstall == 1.12 13:46:15 INFO - mozcrash == 0.16 13:46:15 INFO - mozdebug == 0.1 13:46:15 INFO - mozdevice == 0.47 13:46:15 INFO - mozfile == 1.2 13:46:15 INFO - mozhttpd == 0.7 13:46:15 INFO - mozinfo == 0.9 13:46:15 INFO - mozleak == 0.1 13:46:15 INFO - mozlog == 3.1 13:46:15 INFO - moznetwork == 0.27 13:46:15 INFO - mozprocess == 0.22 13:46:15 INFO - mozprofile == 0.27 13:46:15 INFO - mozrunner == 6.11 13:46:15 INFO - mozscreenshot == 0.1 13:46:15 INFO - mozsystemmonitor == 0.0 13:46:15 INFO - moztest == 0.7 13:46:15 INFO - mozversion == 1.4 13:46:15 INFO - psutil == 3.1.1 13:46:15 INFO - requests == 1.2.3 13:46:15 INFO - wsgiref == 0.1.2 13:46:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:46:15 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')]} 13:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:15 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')]} 13:46:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:15 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 0x7fe413516c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13766c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1427900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146db70>, '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 0x14bedc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bf250>, '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': '61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653', '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 13:46:15 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 13:46:15 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 13:46:15 INFO - Using env: {'DISPLAY': ':0', 13:46:15 INFO - 'HOME': '/home/cltbld', 13:46:15 INFO - 'LANG': 'en_US.UTF-8', 13:46:15 INFO - 'LANGUAGE': 'en_US:en', 13:46:15 INFO - 'LOGNAME': 'cltbld', 13:46:15 INFO - 'MAIL': '/var/mail/cltbld', 13:46:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:15 INFO - 'MOZ_NO_REMOTE': '1', 13:46:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:15 INFO - 'NO_EM_RESTART': '1', 13:46:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:46:15 INFO - 'PWD': '/builds/slave/test', 13:46:15 INFO - 'SHELL': '/bin/bash', 13:46:15 INFO - 'SHLVL': '1', 13:46:15 INFO - 'TERM': 'linux', 13:46:15 INFO - 'TMOUT': '86400', 13:46:15 INFO - 'USER': 'cltbld', 13:46:15 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653', 13:46:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:15 INFO - '_': '/tools/buildbot/bin/python'} 13:46:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:15 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)) 13:46:15 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)) 13:46:15 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)) 13:46:15 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)) 13:46:15 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)) 13:46:15 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)) 13:46:15 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)) 13:46:15 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)) 13:46:15 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)) 13:46:15 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)) 13:46:15 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)) 13:46:15 INFO - Cleaning up... 13:46:15 INFO - Return code: 0 13:46:15 INFO - Running post-action listener: _resource_record_post_action 13:46:15 INFO - Running post-action listener: _start_resource_monitoring 13:46:15 INFO - Starting resource monitoring. 13:46:15 INFO - ##### 13:46:15 INFO - ##### Running install step. 13:46:15 INFO - ##### 13:46:15 INFO - Running pre-action listener: _resource_record_pre_action 13:46:15 INFO - Running main action method: install 13:46:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:46:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:46:15 INFO - Reading from file tmpfile_stdout 13:46:15 INFO - Detecting whether we're running mozinstall >=1.0... 13:46:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:46:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:46:15 INFO - Reading from file tmpfile_stdout 13:46:15 INFO - Output received: 13:46:15 INFO - Usage: mozinstall [options] installer 13:46:15 INFO - Options: 13:46:15 INFO - -h, --help show this help message and exit 13:46:15 INFO - -d DEST, --destination=DEST 13:46:15 INFO - Directory to install application into. [default: 13:46:15 INFO - "/builds/slave/test"] 13:46:15 INFO - --app=APP Application being installed. [default: firefox] 13:46:15 INFO - mkdir: /builds/slave/test/build/application 13:46:15 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'] 13:46:15 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 13:46:29 INFO - Reading from file tmpfile_stdout 13:46:29 INFO - Output received: 13:46:29 INFO - /builds/slave/test/build/application/firefox/firefox 13:46:29 INFO - Running post-action listener: _resource_record_post_action 13:46:29 INFO - ##### 13:46:29 INFO - ##### Running run-tests step. 13:46:29 INFO - ##### 13:46:29 INFO - Running pre-action listener: _resource_record_pre_action 13:46:29 INFO - Running main action method: run_tests 13:46:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:46:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:46:29 INFO - Python 2.7.3 13:46:29 INFO - Return code: 0 13:46:29 INFO - grabbing minidump binary from tooltool 13:46:29 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')]} 13:46:29 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 0x146db70>, '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 0x14bedc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bf250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:46:29 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 13:46:29 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 13:46:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:46:29 INFO - Return code: 0 13:46:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:46:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:46:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:46:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:46:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:46:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] in /builds/slave/test/build 13:46:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost 13:46:29 INFO - Using env: {'DISPLAY': ':0', 13:46:29 INFO - 'HOME': '/home/cltbld', 13:46:29 INFO - 'LANG': 'en_US.UTF-8', 13:46:29 INFO - 'LANGUAGE': 'en_US:en', 13:46:29 INFO - 'LOGNAME': 'cltbld', 13:46:29 INFO - 'MAIL': '/var/mail/cltbld', 13:46:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:46:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:29 INFO - 'MOZ_NO_REMOTE': '1', 13:46:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:46:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:29 INFO - 'NO_EM_RESTART': '1', 13:46:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:46:29 INFO - 'PWD': '/builds/slave/test', 13:46:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:46:29 INFO - 'SHELL': '/bin/bash', 13:46:29 INFO - 'SHLVL': '1', 13:46:29 INFO - 'TERM': 'linux', 13:46:29 INFO - 'TMOUT': '86400', 13:46:29 INFO - 'USER': 'cltbld', 13:46:29 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653', 13:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:29 INFO - '_': '/tools/buildbot/bin/python'} 13:46:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] with output_timeout 3600 13:46:30 INFO - mozversion INFO | application_buildid: 20151123115619 13:46:30 INFO - mozversion INFO | application_changeset: 8705b0a58e1abd8a4d8f23e5d83caeda48bdbfe2 13:46:30 INFO - mozversion INFO | application_display_name: Nightly 13:46:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:46:30 INFO - mozversion INFO | application_name: Firefox 13:46:30 INFO - mozversion INFO | application_remotingname: firefox 13:46:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 13:46:30 INFO - mozversion INFO | application_vendor: Mozilla 13:46:30 INFO - mozversion INFO | application_version: 45.0a1 13:46:30 INFO - mozversion INFO | platform_buildid: 20151123115619 13:46:30 INFO - mozversion INFO | platform_changeset: 8705b0a58e1abd8a4d8f23e5d83caeda48bdbfe2 13:46:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 13:46:30 INFO - mozversion INFO | platform_version: 45.0a1 13:46:30 INFO - 2015-11-23 13:46:30,140 DEBUG : using testdate: 1448315190 13:46:30 INFO - 2015-11-23 13:46:30,140 DEBUG : actual date: 1448315190 13:46:30 INFO - 2015-11-23 13:46:30,148 INFO : starting webserver on 'localhost:34387' 13:46:30 INFO - 2015-11-23 13:46:30,149 INFO : Starting test suite talos-linux64-ix-045 13:46:30 INFO - 2015-11-23 13:46:30,149 INFO : Starting test dromaeo_css 13:46:30 INFO - 2015-11-23 13:46:30,150 DEBUG : operating with platform_type : linux_ 13:46:30 INFO - 2015-11-23 13:46:30,150 INFO : Initialising browser for dromaeo_css test... 13:46:30 INFO - 2015-11-23 13:46:30,165 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAvDzDm/profile http://localhost:34387/getInfo.html 13:46:34 INFO - 2015-11-23 13:46:34,361 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:46:34 INFO - 2015-11-23 13:46:34,362 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:46:34 INFO - 2015-11-23 13:46:34,362 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:46:34 INFO - 2015-11-23 13:46:34,362 DEBUG : BROWSER_OUTPUT: __metrics 13:46:34 INFO - 2015-11-23 13:46:34,478 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:46:35 INFO - 2015-11-23 13:46:35,785 INFO : Browser initialized. 13:46:35 INFO - 2015-11-23 13:46:35,785 INFO : Running cycle 1/1 for dromaeo_css test... 13:46:35 INFO - 2015-11-23 13:46:35,785 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAvDzDm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:46:47 INFO - 2015-11-23 13:46:47,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 139816960 13:46:47 INFO - 2015-11-23 13:46:47,690 DEBUG : BROWSER_OUTPUT: 13:47:38 INFO - 2015-11-23 13:47:38,881 DEBUG : BROWSER_OUTPUT: 1448315258879 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] 13:49:50 INFO - 2015-11-23 13:49:50,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34387/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34387/tests/dromaeo/cssquery-ext.html) 13:49:52 INFO - 2015-11-23 13:49:52,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 248926208 13:49:52 INFO - 2015-11-23 13:49:52,008 DEBUG : BROWSER_OUTPUT: 13:52:54 INFO - 2015-11-23 13:52:54,601 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34387/tests/dromaeo/cssquery-ext.html (next: http://localhost:34387/tests/dromaeo/cssquery-jquery.html) 13:52:55 INFO - 2015-11-23 13:52:55,169 DEBUG : BROWSER_OUTPUT: RSS: Main: 221413376 13:52:55 INFO - 2015-11-23 13:52:55,169 DEBUG : BROWSER_OUTPUT: 13:55:57 INFO - 2015-11-23 13:55:57,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34387/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34387/tests/dromaeo/cssquery-mootools.html) 13:55:57 INFO - 2015-11-23 13:55:57,944 DEBUG : BROWSER_OUTPUT: RSS: Main: 221941760 13:55:57 INFO - 2015-11-23 13:55:57,944 DEBUG : BROWSER_OUTPUT: 13:58:59 INFO - 2015-11-23 13:58:59,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34387/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34387/tests/dromaeo/cssquery-prototype.html) 13:59:00 INFO - 2015-11-23 13:59:00,444 DEBUG : BROWSER_OUTPUT: RSS: Main: 208322560 13:59:00 INFO - 2015-11-23 13:59:00,444 DEBUG : BROWSER_OUTPUT: 14:02:03 INFO - 2015-11-23 14:02:03,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34387/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34387/tests/dromaeo/cssquery-yui.html) 14:02:03 INFO - 2015-11-23 14:02:03,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 208322560 14:02:03 INFO - 2015-11-23 14:02:03,777 DEBUG : BROWSER_OUTPUT: 14:05:06 INFO - 2015-11-23 14:05:06,362 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34387/tests/dromaeo/cssquery-yui.html (next: http://localhost:34387/tests/dromaeo/cssquery-dojo.html) 14:05:06 INFO - 2015-11-23 14:05:06,620 DEBUG : BROWSER_OUTPUT: RSS: Main: 225894400 14:05:06 INFO - 2015-11-23 14:05:06,620 DEBUG : BROWSER_OUTPUT: 14:05:06 INFO - 2015-11-23 14:05:06,620 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:05:06 INFO - 2015-11-23 14:05:06,620 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:05:06 INFO - 2015-11-23 14:05:06,620 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:05:06 INFO - 2015-11-23 14:05:06,620 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:05:06 INFO - 2015-11-23 14:05:06,620 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2612.3730304726864;2711.308616302844;2727.904523341683;2733.5489644208706;2737.4935636907176;4510.25580779171;4610.308453731937;4632.490426053136;4656.324832899236;4675.298705194223;4609.838655647053;4623.815047398109;4708.128996135709;4742.027884283722;4744.478107408191;4306.0414976583525;4339.218940590692;4352.281873490871;4353.434053573031;4378.036831896978;4166.062635906912;4350.956490435103;4356.281213599768;4398.054418300065;4401.845935392262;4213.30480470722;4247.299195632748;4278.72188307759;4285.785710714452;4310.849120280806;4254.829806807724;4270.359446083081;4282.785860706952;4287;4299.355096735483;4091.4067460218102;4198.097409057037;4219.43037689911;4244.787760611988;4285.35719642053;4489.304157855538;4570.954290457086;4594.839180628695;4617.792199351037;4652.790624421909;4933.950660493385;4944.060628480577;4945.950540494585;4949.109160351135;4965.851024469235;4794.280857871312;4900.950990490085;4963.131451995886;4978.800847966077;5018.64869459138;4598.977005114986;4621.8151273949;4661.114388266218;4669.182892993713;4723.905521889543;5108.080545501845;5122.436531981479;5125.923111153335;5136.666116702402;5174.534291913746;4690.132325519789;4827.541383568555;4915.336429582032;4931.4821943696115;4972.378452693413;4886.657933944661;4912.459629440758;4940.086084074458;4957.504249575014;4989.850304490798;4933.309336692866;4996.750162491933;4997.000599880039;5002.149634562061;5045.5459008689395;4740.597049250852;4828.95171048292;4939.2838038484215;4953.826616068421;5004.3994720633755;4064.5122585289955;4109.301418758818;4113.835446582163;4138.420621113047;4139.8965025874595;3647.379945409287;3656.5063716397945;3666.6883314917995;3666.688331491853;3697.3159965406485;4131.8967025824595;4301.526832048535;4309.159713855768;4309.181255561433;4347.174036932973;4782.497837727058;4818.518148185153;4856.368672072608;4865.8053677853195;4867.756612169377;4329.9134017319475;4356.302991521405;4365.257906155961;4374.846880359172;4405.581469760367;4453.621442177451;4457.5988161065015;4460;4460.955390446054;4501.842435514807;4535.6371490280035;4636.258198688193;4640.04878999811;4789.592884604847;4801.423829140455;4863.319135321129;4874.2201247800185;4875.561199492063;4878.975605122094;4926.975365123295;4762.761861906822;4767.427908650984;4769.856904292877;4773.618110551217;4804.8798780030775;4699.060187962353;4800.687955282895;4804.279358096313;4942.925856112233;4997.125503037027;4826.613870890391;4914.680545764514;4950;4950.282209079735;4970.9254361183885;4803.255495398219;4851.878703032311;4865.197242454955;4871.0501452217895;4912.901741965212;4697.953020469751;4830.565249127595;4831.903361932812;4863.416390033219;4892.437369702529;4595.954040459686;4672.159011377848;4672.509386514367;4672.7429991349445;4677.46209185948;4871.610271178368;4920.778564964657;4920.803167873245;4923.236898280772;4964.304997300309;4539.069490754454;4665.183592871302;4799.040191961692;4814.855554333376;4817.8313759018265 14:05:06 INFO - 2015-11-23 14:05:06,621 DEBUG : BROWSER_OUTPUT: |1;ext.html;534.9037173308806;546.8250159948813;570.9343425506066;570.9714514274285;575.3354875119236;28022;28636;36608.63391366082;37362.8131859341;37505.249895002155;39328.803355983255;40121.79939100308;40198.19603607926;40206.597934020654;40301.76077109972;6851.931480685204;7880.64537095832;8042;8042.034955805311;8047.195280471965;6989.930100698979;7104;7104.609246491441;7105.573665580056;10138.290319677626;9921.35511191774;10047.447390393525;10050.64822731201;10050.9497452513;10061.748456288578;9991.90008099917;10109.39343639384;10112.747181320452;10114.241431892564;10117;7035.366816986496;7223.169335526429;9869.901300987041;10076.596936122547;10430.426326552037;36421.27157456836;36939;36949;36952.630473695455;36985.26029479395;2737.425140720451;2783.067672329772;2815.9155225343275;3364.3775901458307;3373;27627.171184864485;27996.720032799818;28026.579601305995;28262.717372826213;28399.43201135966;3147.5750773645723;3204.3110731192905;3278.672132786702;3304.1244070321386;3333.1667083229195;222131;224986;225152;225263;225326;45648.77175614101;55099;55406.445935540934;55429;55465.44534554603;43435.74231932618;43616.563834361885;43618.78190609027;62104.37895621076;63389;13486;13706.794398084037;13835.100718453268;13849.792253116211;13893.930530347283;9672.322937394314;9678.128968392879;9686.418814871131;9695.369800962915;9700.951495242478;18826.811731882506;18864.811351886307;19006.42980710553;19051;19054.714179287323;7403;7724.575148366894;7806.843863122819;7817.413693972975;7920.207979202149;836.602613758472;917.8118485710547;944.9102335278137;994.6916455898695;1049.9527521261562;25765.3558661035;25847.35381615437;25931.611025834627;26005.219843404728;29148;918.196577994255;920.2224120618067;924.8150369926042;949.0414681172066;1015.5937624950079;15169.924150379178;15806.525804225892;16008.279627416794;16038.198090095448;16225.837741622669;327946;332232;332277;333613;333696;48432.75783621059;48834;48841;48914.510854891705;48942.37162726261;1192.1416580062341;1212.042486435706;1224.2470880408484;1224.8530176378713;1227.404708716272;26388.472230554897;27409.31476713098;27488.45023099487;27773.583396249476;27890.581641275803;30038.549421758253;30555.54166687457;38968.6103138965;43648.56351436445;44474.332885007396;209814;210478;212148;212459;212482;22716.65925011093;28087.859560702065;28496.43007139887;28650.856745716137;28654.426911461236;25637.23088307354;28166.71833281723;36844.63155368412;37526.81236593799;37569.4364584526;37674.81162594279;37689;38949.6105038946;39263.80368098256;39424;33210.5018424719;33315.33369332648;34119.65880341165;34256.486152708225;34278.48582271218;34287.14282142966;34893.127671808405;34949;34953.47569786404;34999.12502187466;30128.548071778503;30204.24489387695;30567.23581910381;31211.531827023067;31255.84372078125;23582.17462388808;23789.167379141647;23931.65795143001;24010.87994560086;24227.273181804576 14:05:06 INFO - 2015-11-23 14:05:06,621 DEBUG : BROWSER_OUTPUT: |2;jquery.html;314.75291895861756;329.1081170029221;334.1395905543227;336.04227950341516;338.72732450377447;12034.699132521691;12219.694507637314;15015.624609384771;15533.378664853406;15735.527934161964;12433.254004759721;12472.438740256688;12544.937275313634;14563.563093107225;15270.923645381758;4530.569595888385;4630.189716799563;4646.953530464702;4676.672632915697;4887.364642596457;3338.2155193529625;3463.393906066441;4977.825776097838;5164.406093299281;5167.974160129194;5083.567896728782;5105.489451054883;5110.718910459923;5144.56271216947;5148.073346797575;5054.1407960646775;5101.081805275067;5171.974140129275;5173.068847607429;5176.456472070416;4975.950240497585;4977.178765503688;4988.052270068675;4996.125678006334;4996.300517927493;18417.723734143998;18812.24751009958;19130.139143738565;19133.1390087445;19277.22891084355;1790.910454477284;1802.0809387212485;1825.9269629214816;1851.9074046297767;1857.7492038574755;8758.649654013832;8865.867011994826;8976.820463590757;8980.55097245135;9140.6800761973;1730.0935319443781;1737.8435940765391;1744.7350670763722;1803.6753384390804;1836.0819590204896;52292.73853630746;53316.20025699618;54476;55875;56891.715541422025;9698.418094914328;9717.61129554824;9768.902310976799;9770.169535589412;9785.412875227508;12384.256944583354;12443.25340479556;12445.004399648007;12462;12477.812832807514;6711.832204194837;6836.5214434989075;6943.756968506078;6983.615901125487;7037.155541334971;6705.966470167618;6709.161354830646;6710.563813352116;6751.324867513209;6781.389674929182;4135.60711732385;4138.710290279711;4149.3775933609595;4165;4181.686373521998;1578.2661062605944;1630.600502876779;1653.3717187468926;1663.8003439587328;1701.9404320848712;364.3932851801773;366.1870647163293;377.98488060477274;824.7360844529812;868.0928429790883;9193.678221262357;9266.814663706687;9326.160645541933;9465.858012129824;9536.2371010319;377.6318089862417;381.4526154967575;399.4387885021549;408.30384194947544;409.14080431094465;5096.541311282002;5506.339239291311;5576.832695019156;9247.907520924704;9771.51142442875;469986;479249;483484;485538;486224;68210;69475.65262173656;69670;71855;72125.2787472129;1057.5505410200633;1066.168388656849;1073.4900922061959;1074.4949873559415;1075.3386667199773;14639.560813175622;14643.633909152357;14655.85344146545;14885;15125.39498420051;31845.36309273848;32266;32291.838540807144;32395.676043240208;32408.83795581007;43268.56731432645;43702.12595748131;43801.34297985469;43837;46459;8836.469811811312;8971.327150463872;8978.102189781232;8994.190522852974;9059.954700226457;15166.24168791578;15204.087754734752;15511.224438778241;15867.444639437565;16039.919800400923;12954.417051232529;13087.476500939856;13243.66890827737;13265.336733163496;13444.932775336061;12797;12962.935185324013;13100.737985240432;13449.731005380034;13476.663083422993;13181.340932953506;13437.596872093853;13738.725225495235;13850;13997.930010349883;7307.7807665770115;7534.585597792174;8586.871196931927;8670.82658346817;9026.68406605792;9350.25197984146;9392.060793920553;12962.870371296167;13581.592552223448;13619.727605448034 14:05:06 INFO - 2015-11-23 14:05:06,621 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1341.9463221471142;1346.1788309131434;1390.7635701930672;1528.5490780219834;1600.471844291384;5903.704814759261;6418.871622567546;6550.082988381619;6550.410463058324;6566.901496477551;6570.113034740309;6685.130932978706;6689.130413046297;6695.598264104157;6700.3299670032975;2059.6910463430495;2077.356019633911;2079.6984437256588;2081.698153767703;2081.8334533237303;2058.4133521946246;2059.258666879922;2091.7908209179113;2119.2688522459725;2122.9999999999923;2006.6388050150968;2026.7669218039894;2038.0828627117783;2041.5304479969616;2041.5508588110592;2070.2029718558315;2078.0856423173905;2079.854410191287;2082.312836763864;2082.6980087887246;2053.2813515269686;2067.3487851326786;2073.9585208295903;2074.5850829833944;2083.7082808406835;5611.2144299798065;5718.656880587178;6750.054992301082;6771.93228067718;6796.35434633709;3858.6913046956456;4008.118213992946;4012.8996775080564;4015.156817068419;4031.7984100794843;2665.333666583354;2666.7599916007457;2693.824901381404;2733.4669739400824;2733.7539621434166;886.5965985476593;898.9280857531381;912.3066469483174;913.2739472119681;914.0950459045564;8957.507337096456;8971.820563588692;9018.954905225497;9022.18800307969;9048.230900373475;3798.525184351956;3810.8285127169343;3857.1707082977296;3863.362545180014;3865.1883104547796;7938;7947.483413578215;7956.2441568050945;7956.801079973047;7976.322012628875;4210.115875666144;4214.388913607571;4221.5778422158155;4222.535521092677;4228.112096459717;3821.082940094357;3821.808909554511;3823.0824602095295;3825.5600605930117;3827.0623697194364;3111.7510599152015;3133.8903138390046;3148.5434611981136;3175.1903264667826;3178.030700636328;1006.0442579549457;1019.1490105761624;1025.620520407439;1034.7723500829804;1038.9896101039044;1089.6513115803025;1105.563302495526;1106.7399161197113;1107.734143805481;1161.517970042423;6357.332480089616;6407.839804004844;6409.775657851953;6412.454941330039;6416.262129855127;1054.2356791326226;1077.3893029920318;1096.4353358020626;1110.9777804444027;1124.6288724720823;4517.164324599959;5087.669301495391;5136.666116702402;5203.973980130075;5204.557612602971;7431.331180193701;7825.295723384809;8082.110967793538;8131.308838748772;8143.470674406145;7987.16134805837;8022.358211343078;8026.438149329608;8026.478278911852;8046.879296810553;6162.845928851814;6468.15913931186;6477.611343319416;6481.48148148147;6504.577202481823;6456.677166141768;6473.546851720523;6487.124238227779;6496.447801936699;6503.642299673564;7258.165310989304;7374.446916481178;7460.179380268058;7469.402447804054;7472.252774722484;7400.407967362706;7626.313631773167;7632;7658.846823063619;7683.116441609286;5691.288588926384;5699.202111704281;5705.429457054262;5765.91351129725;5768.6538807669995;6554.63949482783;6626.469882409492;6641.800745977628;6650.334966503505;6657.901446261312;6105.48103411215;6200.534959877937;6232.065190221503;6345.555811093363;6378.776742814165;6144.600600960924;6168.629882207082;6184.474319682698;6241.063840423973;6269.905951410641;6276.089966954674;6312.5265605078885;6318.526110541636;6335.303116657072;6338.90491642635;5780;5807.157962095388;5820.185174075717;5831.7375718091935;5832.883342333044;5865.589408741347;5900.822975310747;5934.406559344204;5942.019566771607;5944.108383742473 14:05:06 INFO - 2015-11-23 14:05:06,624 DEBUG : BROWSER_OUTPUT: |4;prototype.html;304.922244827569;309.3056089080015;312.36745590179885;317.09153275864657;318.50472515238823;5379.327584051994;5409.8106566270135;5485.286912701353;5494.560435165187;5512.6968016759065;5377.516023557879;5389.892202155955;5390.056740070491;5402.702851343174;5406.459354064592;3946.0923987482897;4075.9592404076025;4224.683148763839;4229.344451610005;4236.872893813183;4067.837286508536;4151.543330233671;4167.729097608646;4172.666186705072;4176.582341765814;4117.75293482392;4119.073208528072;4120.505539335284;4127.669786417095;4136.31750761124;3936.6457018868296;4037.0916543777416;4038.6567141792984;4121.587841215869;4134.37984302354;3654.049947013769;3662.6520480554573;3664.3404187246283;3671.284099600579;3672.265546890633;5148.3564554430695;5156.123459011977;5157.123289040872;5157.30376399185;5165.845024649229;4797.856064318076;4809.0862736080035;4812.470628230892;4812.807487700487;4825.203841366206;5531.170324451325;5655.660660360391;5663.292088488939;5668.4614961579;5678.119891416795;4057.3305404608204;4067.2068946555432;4075.2257071156682;4080.10237747695;4082.346824508094;5958.523318134538;5961.582689211757;5966.075258334965;5970.34326224115;5976.013957696975;4200.1179752251755;4206;4211.052513184509;4217.493900731932;4218.093109981307;4193.224253513049;4246.426732391149;4281.207976524353;4282.678799090018;4300.1399720056115;4787.521247875185;4793.49668284832;4827.662063655511;4834.854954351375;4839.322494850724;5616.1856530803625;5642;5671.914921276184;5673.461021202979;5677.971610141923;1491.0084793612343;1507.3443052272296;1508.8113985751781;1509.7207016701946;1510.5921401221608;1038.6883934819523;1043.4261156363968;1045.2421994054403;1061.6125114333213;1069.5668254356997;5007.39911210657;5011.949880501221;5011.997600479918;5012.47369026247;5017.197248440232;5898.528117750569;5898.587098903122;5900;5904.822855314347;5911.674857882857;4975.353204083518;4991.951690145038;5010.3737032870895;5014.749262536931;5018.397792264952;2933.2080338308538;2988.581598576201;3130.1705048162257;3132.060381885425;3162.8418579070953;5549.250851135126;5635.070213414822;5637.49262566371;5642.971785141131;5648.068068768689;6107.694615269219;6111.449969502766;6115.807417553623;6122.081687746784;6137.723802428902;5621.297337832771;5628.549716022709;5630.155476678449;5633.183188437735;5635.98552260597;5833.708314584169;5935.317438494456;5975.37258587842;5975.7012149391485;5979.3123790762875;5815.389384114607;5816.651000939957;5822;5825.825225243249;5834.066549352084;5620.072688006433;5626.493615574618;5628.212050312877;5628.718564071862;5642.294713160855;4177.540470548298;4269.594388533084;4273.572642735701;4276.037891474393;4283.957160428356;5948.137520059654;5952.672603006876;5952.672603006876;5957.523398128053;5961.165436838759;5729.570282228933;5740.856478587902;5741.799037033684;5746.942530574808;5749.655020698771;5653.802116925888;5706.2011318414625;5716.085426331767;5722.828315150552;5731.083026715705;5382.4886635769535;5521.503064724194;5531.391546929915;5598.188262701967;5606.299212598426;5752.68360240174;5786.045302525036;5790.739416726173;5796.82609521715;5800.651960882361;5412.675239485643;5490.91763623538;5549.1676248563035;5549.223108764695;5556.499915007668 14:05:06 INFO - 2015-11-23 14:05:06,624 DEBUG : BROWSER_OUTPUT: |5;yui.html;635.5106567942682;640.849400390908;666.9995007488767;707.8336590901138;772.7449941519295;10921.617743378984;11246.325220486757;11248;11253.66239012829;11261.155413343991;11345.886541134587;11433.599824006162;11507.942460287686;11531.48108335125;12903.54837580685;760.118262815136;776.1036003416064;776.2005134711256;777.2848978939361;777.5606782168085;619.5446346934999;625.1185827982546;626.5801912718467;762.2301475509747;777.8677624803797;794.043177970547;801.7594721583531;809.465752603282;810.6635746165334;811.1645005644195;633.550179372646;799.436397339874;799.588212070784;800.6477150053958;800.6917336825335;472.7494427953156;577.1314172170898;587.6562211106508;590.0529649911873;590.0706387439757;11803.704907377298;12006.879931200663;12009.819852702216;12031.819522707166;12035.759284814254;10258.846117308247;10638.308509946828;10806.459677016197;11006.559737610485;11070.667879963534;8790.692325768567;8806.515641639708;8937.6871809487;8977.147171018743;9014.278857691435;3145.433821912055;3228.757843161772;3229.5963004624423;3244.513323001545;3246.6753324667343;41821.091518224646;41869.581304186875;42319.1536169278;42329.365059524134;42406;8876.556172191365;8892.822143557221;9070.047644997181;9173.174414302744;9265.7954465919;15175.696486070217;15202.087874727551;15213.467528636445;15225;15225.923870380799;5895.882082358415;6140.201773769381;6217.098520714561;6321.778737744157;6543.01854721786;3519.436890097572;3575.535180426528;3629.6007439181667;3654.926901462009;3710.962890371116;2501.287133167075;2514.7862431693147;2519.9748002520105;2522.709888362825;2526.456811785475;466.20512026993896;471.25541644202764;485.7085748550841;490.11778798163874;490.65899200056333;423.3564981228515;449.1062785057712;460.66831881045596;472.29156265601597;500.6670564074922;6892.793216203522;6924.549904256207;6937.791866244021;6976.965115174392;6986.720531178696;419.3290734824318;473.8649484896788;479.5204795204795;499.4306490600718;500.37453183520597;3272.754543409254;3361.3949489092197;3437.5359326491102;3573.7855728656364;3632.146445585285;53327.20009199865;53382;53442.73278633582;53478.46521534813;53538.73230633822;43047.35428968568;43499.78250108729;43534.34698479525;43574.56425435768;45937.540624593996;36912;37390.439143413416;37455.81272093622;37514.81242593769;37671;7346.7061317546695;7360.368316084935;7468.626568671436;7646.749013723423;7695.538267703956;32673.509897351083;32736.181595460304;33436.33127337488;33511.66488335085;33655.326893461504;38921;38962.6103738959;42633;42764;43016.569834301255;8817.250533704708;8892.555372231493;8909.331800115147;9209.585568649292;9668.75828104303;10598.364098154136;10790;10932.289401188897;11005.61480348184;11204.439778010903;8704.78238044054;8747.212750852454;8914.465132092095;8968.71229312419;9209.355345125778;9056.230220431336;9083.318751093562;9235.907640923504;9311.767205819639;9350.345475816628;8058.355331573577;8653.35099867525;9436.669716560162;9480.715578532656;9594.232461402931;8071.677132914618;8126.715564955198;8136.593170341341;8183.63173657175;8191.426600137933;7583.2416758325935;7985.480943738638;8023.879641805494;8079.919200808152;8192.959035205024 14:05:06 INFO - 2015-11-23 14:05:06,624 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:05:06 INFO - 2015-11-23 14:05:06,625 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:05:06 INFO - 2015-11-23 14:05:06,625 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,974 14:05:06 INFO - 2015-11-23 14:05:06,625 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:05:06 INFO - 2015-11-23 14:05:06,625 DEBUG : BROWSER_OUTPUT: __startTimestamp1448316306616__endTimestamp 14:05:06 INFO - 2015-11-23 14:05:06,625 DEBUG : BROWSER_OUTPUT: 14:05:06 INFO - 2015-11-23 14:05:06,625 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:05:06 INFO - 2015-11-23 14:05:06,625 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:05:06 INFO - 2015-11-23 14:05:06,625 DEBUG : BROWSER_OUTPUT: 14:05:06 INFO - 2015-11-23 14:05:06,625 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4582.41 Median:4697.95 stddev:462.34 (9.8%) stddev-sans-first:437.16 14:05:06 INFO - 2015-11-23 14:05:06,626 DEBUG : BROWSER_OUTPUT: Values: 2612.4 2711.3 2727.9 2733.5 2737.5 4510.3 4610.3 4632.5 4656.3 4675.3 4609.8 4623.8 4708.1 4742.0 4744.5 4306.0 4339.2 4352.3 4353.4 4378.0 4166.1 4351.0 4356.3 4398.1 4401.8 4213.3 4247.3 4278.7 4285.8 4310.8 4254.8 4270.4 4282.8 4287.0 4299.4 4091.4 4198.1 4219.4 4244.8 4285.4 4489.3 4571.0 4594.8 4617.8 4652.8 4934.0 4944.1 4946.0 4949.1 4965.9 4794.3 4901.0 4963.1 4978.8 5018.6 4599.0 4621.8 4661.1 4669.2 4723.9 5108.1 5122.4 5125.9 5136.7 5174.5 4690.1 4827.5 4915.3 4931.5 4972.4 4886.7 4912.5 4940.1 4957.5 4989.9 4933.3 4996.8 4997.0 5002.1 5045.5 4740.6 4829.0 4939.3 4953.8 5004.4 4064.5 4109.3 4113.8 4138.4 4139.9 3647.4 3656.5 3666.7 3666.7 3697.3 4131.9 4301.5 4309.2 4309.2 4347.2 4782.5 4818.5 4856.4 4865.8 4867.8 4329.9 4356.3 4365.3 4374.8 4405.6 4453.6 4457.6 4460.0 4461.0 4501.8 4535.6 4636.3 4640.0 4789.6 4801.4 4863.3 4874.2 4875.6 4879.0 4927.0 4762.8 4767.4 4769.9 4773.6 4804.9 4699.1 4800.7 4804.3 4942.9 4997.1 4826.6 4914.7 4950.0 4950.3 4970.9 4803.3 4851.9 4865.2 4871.1 4912.9 4698.0 4830.6 4831.9 4863.4 4892.4 4596.0 4672.2 4672.5 4672.7 4677.5 4871.6 4920.8 4920.8 4923.2 4964.3 4539.1 4665.2 4799.0 4814.9 4817.8 14:05:06 INFO - 2015-11-23 14:05:06,626 DEBUG : BROWSER_OUTPUT: 14:05:06 INFO - 2015-11-23 14:05:06,627 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41505.73 Median:18324.25 stddev:68446.56 (373.5%) stddev-sans-first:68569.44 14:05:06 INFO - 2015-11-23 14:05:06,627 DEBUG : BROWSER_OUTPUT: Values: 534.9 546.8 570.9 571.0 575.3 28022.0 28636.0 36608.6 37362.8 37505.2 39328.8 40121.8 40198.2 40206.6 40301.8 6851.9 7880.6 8042.0 8042.0 8047.2 6989.9 7104.0 7104.6 7105.6 10138.3 9921.4 10047.4 10050.6 10050.9 10061.7 9991.9 10109.4 10112.7 10114.2 10117.0 7035.4 7223.2 9869.9 10076.6 10430.4 36421.3 36939.0 36949.0 36952.6 36985.3 2737.4 2783.1 2815.9 3364.4 3373.0 27627.2 27996.7 28026.6 28262.7 28399.4 3147.6 3204.3 3278.7 3304.1 3333.2 222131.0 224986.0 225152.0 225263.0 225326.0 45648.8 55099.0 55406.4 55429.0 55465.4 43435.7 43616.6 43618.8 62104.4 63389.0 13486.0 13706.8 13835.1 13849.8 13893.9 9672.3 9678.1 9686.4 9695.4 9701.0 18826.8 18864.8 19006.4 19051.0 19054.7 7403.0 7724.6 7806.8 7817.4 7920.2 836.6 917.8 944.9 994.7 1050.0 25765.4 25847.4 25931.6 26005.2 29148.0 918.2 920.2 924.8 949.0 1015.6 15169.9 15806.5 16008.3 16038.2 16225.8 327946.0 332232.0 332277.0 333613.0 333696.0 48432.8 48834.0 48841.0 48914.5 48942.4 1192.1 1212.0 1224.2 1224.9 1227.4 26388.5 27409.3 27488.5 27773.6 27890.6 30038.5 30555.5 38968.6 43648.6 44474.3 209814.0 210478.0 212148.0 212459.0 212482.0 22716.7 28087.9 28496.4 28650.9 28654.4 25637.2 28166.7 36844.6 37526.8 37569.4 37674.8 37689.0 38949.6 39263.8 39424.0 33210.5 33315.3 34119.7 34256.5 34278.5 34287.1 34893.1 34949.0 34953.5 34999.1 30128.5 30204.2 30567.2 31211.5 31255.8 23582.2 23789.2 23931.7 24010.9 24227.3 14:05:06 INFO - 2015-11-23 14:05:06,627 DEBUG : BROWSER_OUTPUT: 14:05:06 INFO - 2015-11-23 14:05:06,627 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25702.31 Median:4157.19 stddev:78600.24 (1890.7%) stddev-sans-first:78797.62 14:05:06 INFO - 2015-11-23 14:05:06,628 DEBUG : BROWSER_OUTPUT: Values: 314.8 329.1 334.1 336.0 338.7 12034.7 12219.7 15015.6 15533.4 15735.5 12433.3 12472.4 12544.9 14563.6 15270.9 4530.6 4630.2 4647.0 4676.7 4887.4 3338.2 3463.4 4977.8 5164.4 5168.0 5083.6 5105.5 5110.7 5144.6 5148.1 5054.1 5101.1 5172.0 5173.1 5176.5 4976.0 4977.2 4988.1 4996.1 4996.3 18417.7 18812.2 19130.1 19133.1 19277.2 1790.9 1802.1 1825.9 1851.9 1857.7 8758.6 8865.9 8976.8 8980.6 9140.7 1730.1 1737.8 1744.7 1803.7 1836.1 52292.7 53316.2 54476.0 55875.0 56891.7 9698.4 9717.6 9768.9 9770.2 9785.4 12384.3 12443.3 12445.0 12462.0 12477.8 6711.8 6836.5 6943.8 6983.6 7037.2 6706.0 6709.2 6710.6 6751.3 6781.4 4135.6 4138.7 4149.4 4165.0 4181.7 1578.3 1630.6 1653.4 1663.8 1701.9 364.4 366.2 378.0 824.7 868.1 9193.7 9266.8 9326.2 9465.9 9536.2 377.6 381.5 399.4 408.3 409.1 5096.5 5506.3 5576.8 9247.9 9771.5 469986.0 479249.0 483484.0 485538.0 486224.0 68210.0 69475.7 69670.0 71855.0 72125.3 1057.6 1066.2 1073.5 1074.5 1075.3 14639.6 14643.6 14655.9 14885.0 15125.4 31845.4 32266.0 32291.8 32395.7 32408.8 43268.6 43702.1 43801.3 43837.0 46459.0 8836.5 8971.3 8978.1 8994.2 9060.0 15166.2 15204.1 15511.2 15867.4 16039.9 12954.4 13087.5 13243.7 13265.3 13444.9 12797.0 12962.9 13100.7 13449.7 13476.7 13181.3 13437.6 13738.7 13850.0 13997.9 7307.8 7534.6 8586.9 8670.8 9026.7 9350.3 9392.1 12962.9 13581.6 13619.7 14:05:06 INFO - 2015-11-23 14:05:06,628 DEBUG : BROWSER_OUTPUT: 14:05:06 INFO - 2015-11-23 14:05:06,629 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4781.51 Median:5832.31 stddev:2408.01 (41.3%) stddev-sans-first:2400.89 14:05:06 INFO - 2015-11-23 14:05:06,629 DEBUG : BROWSER_OUTPUT: Values: 1341.9 1346.2 1390.8 1528.5 1600.5 5903.7 6418.9 6550.1 6550.4 6566.9 6570.1 6685.1 6689.1 6695.6 6700.3 2059.7 2077.4 2079.7 2081.7 2081.8 2058.4 2059.3 2091.8 2119.3 2123.0 2006.6 2026.8 2038.1 2041.5 2041.6 2070.2 2078.1 2079.9 2082.3 2082.7 2053.3 2067.3 2074.0 2074.6 2083.7 5611.2 5718.7 6750.1 6771.9 6796.4 3858.7 4008.1 4012.9 4015.2 4031.8 2665.3 2666.8 2693.8 2733.5 2733.8 886.6 898.9 912.3 913.3 914.1 8957.5 8971.8 9019.0 9022.2 9048.2 3798.5 3810.8 3857.2 3863.4 3865.2 7938.0 7947.5 7956.2 7956.8 7976.3 4210.1 4214.4 4221.6 4222.5 4228.1 3821.1 3821.8 3823.1 3825.6 3827.1 3111.8 3133.9 3148.5 3175.2 3178.0 1006.0 1019.1 1025.6 1034.8 1039.0 1089.7 1105.6 1106.7 1107.7 1161.5 6357.3 6407.8 6409.8 6412.5 6416.3 1054.2 1077.4 1096.4 1111.0 1124.6 4517.2 5087.7 5136.7 5204.0 5204.6 7431.3 7825.3 8082.1 8131.3 8143.5 7987.2 8022.4 8026.4 8026.5 8046.9 6162.8 6468.2 6477.6 6481.5 6504.6 6456.7 6473.5 6487.1 6496.4 6503.6 7258.2 7374.4 7460.2 7469.4 7472.3 7400.4 7626.3 7632.0 7658.8 7683.1 5691.3 5699.2 5705.4 5765.9 5768.7 6554.6 6626.5 6641.8 6650.3 6657.9 6105.5 6200.5 6232.1 6345.6 6378.8 6144.6 6168.6 6184.5 6241.1 6269.9 6276.1 6312.5 6318.5 6335.3 6338.9 5780.0 5807.2 5820.2 5831.7 5832.9 5865.6 5900.8 5934.4 5942.0 5944.1 14:05:06 INFO - 2015-11-23 14:05:06,629 DEBUG : BROWSER_OUTPUT: 14:05:06 INFO - 2015-11-23 14:05:06,630 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4741.00 Median:5378.42 stddev:1386.15 (25.8%) stddev-sans-first:1349.45 14:05:06 INFO - 2015-11-23 14:05:06,630 DEBUG : BROWSER_OUTPUT: Values: 304.9 309.3 312.4 317.1 318.5 5379.3 5409.8 5485.3 5494.6 5512.7 5377.5 5389.9 5390.1 5402.7 5406.5 3946.1 4076.0 4224.7 4229.3 4236.9 4067.8 4151.5 4167.7 4172.7 4176.6 4117.8 4119.1 4120.5 4127.7 4136.3 3936.6 4037.1 4038.7 4121.6 4134.4 3654.0 3662.7 3664.3 3671.3 3672.3 5148.4 5156.1 5157.1 5157.3 5165.8 4797.9 4809.1 4812.5 4812.8 4825.2 5531.2 5655.7 5663.3 5668.5 5678.1 4057.3 4067.2 4075.2 4080.1 4082.3 5958.5 5961.6 5966.1 5970.3 5976.0 4200.1 4206.0 4211.1 4217.5 4218.1 4193.2 4246.4 4281.2 4282.7 4300.1 4787.5 4793.5 4827.7 4834.9 4839.3 5616.2 5642.0 5671.9 5673.5 5678.0 1491.0 1507.3 1508.8 1509.7 1510.6 1038.7 1043.4 1045.2 1061.6 1069.6 5007.4 5011.9 5012.0 5012.5 5017.2 5898.5 5898.6 5900.0 5904.8 5911.7 4975.4 4992.0 5010.4 5014.7 5018.4 2933.2 2988.6 3130.2 3132.1 3162.8 5549.3 5635.1 5637.5 5643.0 5648.1 6107.7 6111.4 6115.8 6122.1 6137.7 5621.3 5628.5 5630.2 5633.2 5636.0 5833.7 5935.3 5975.4 5975.7 5979.3 5815.4 5816.7 5822.0 5825.8 5834.1 5620.1 5626.5 5628.2 5628.7 5642.3 4177.5 4269.6 4273.6 4276.0 4284.0 5948.1 5952.7 5952.7 5957.5 5961.2 5729.6 5740.9 5741.8 5746.9 5749.7 5653.8 5706.2 5716.1 5722.8 5731.1 5382.5 5521.5 5531.4 5598.2 5606.3 5752.7 5786.0 5790.7 5796.8 5800.7 5412.7 5490.9 5549.2 5549.2 5556.5 14:05:06 INFO - 2015-11-23 14:05:06,630 DEBUG : BROWSER_OUTPUT: 14:05:06 INFO - 2015-11-23 14:05:06,630 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12017.82 Median:26913.93 stddev:14231.82 (52.9%) stddev-sans-first:14246.07 14:05:06 INFO - 2015-11-23 14:05:06,631 DEBUG : BROWSER_OUTPUT: Values: 635.5 640.8 667.0 707.8 772.7 10921.6 11246.3 11248.0 11253.7 11261.2 11345.9 11433.6 11507.9 11531.5 12903.5 760.1 776.1 776.2 777.3 777.6 619.5 625.1 626.6 762.2 777.9 794.0 801.8 809.5 810.7 811.2 633.6 799.4 799.6 800.6 800.7 472.7 577.1 587.7 590.1 590.1 11803.7 12006.9 12009.8 12031.8 12035.8 10258.8 10638.3 10806.5 11006.6 11070.7 8790.7 8806.5 8937.7 8977.1 9014.3 3145.4 3228.8 3229.6 3244.5 3246.7 41821.1 41869.6 42319.2 42329.4 42406.0 8876.6 8892.8 9070.0 9173.2 9265.8 15175.7 15202.1 15213.5 15225.0 15225.9 5895.9 6140.2 6217.1 6321.8 6543.0 3519.4 3575.5 3629.6 3654.9 3711.0 2501.3 2514.8 2520.0 2522.7 2526.5 466.2 471.3 485.7 490.1 490.7 423.4 449.1 460.7 472.3 500.7 6892.8 6924.5 6937.8 6977.0 6986.7 419.3 473.9 479.5 499.4 500.4 3272.8 3361.4 3437.5 3573.8 3632.1 53327.2 53382.0 53442.7 53478.5 53538.7 43047.4 43499.8 43534.3 43574.6 45937.5 36912.0 37390.4 37455.8 37514.8 37671.0 7346.7 7360.4 7468.6 7646.7 7695.5 32673.5 32736.2 33436.3 33511.7 33655.3 38921.0 38962.6 42633.0 42764.0 43016.6 8817.3 8892.6 8909.3 9209.6 9668.8 10598.4 10790.0 10932.3 11005.6 11204.4 8704.8 8747.2 8914.5 8968.7 9209.4 9056.2 9083.3 9235.9 9311.8 9350.3 8058.4 8653.4 9436.7 9480.7 9594.2 8071.7 8126.7 8136.6 8183.6 8191.4 7583.2 7985.5 8023.9 8079.9 8193.0 14:05:06 INFO - 2015-11-23 14:05:06,631 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:05:06 INFO - 2015-11-23 14:05:06,631 DEBUG : BROWSER_OUTPUT: 14:05:07 INFO - 2015-11-23 14:05:07,272 INFO : Browser exited with error code: 0 14:05:07 INFO - 2015-11-23 14:05:07,295 INFO : Completed test dromaeo_css (00:18:37) 14:05:07 INFO - 2015-11-23 14:05:07,295 INFO : Starting test kraken 14:05:07 INFO - 2015-11-23 14:05:07,295 DEBUG : operating with platform_type : linux_ 14:05:07 INFO - 2015-11-23 14:05:07,295 INFO : Initialising browser for kraken test... 14:05:07 INFO - 2015-11-23 14:05:07,301 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn6jIN3/profile http://localhost:34387/getInfo.html 14:05:11 INFO - 2015-11-23 14:05:11,195 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:05:11 INFO - 2015-11-23 14:05:11,196 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:05:11 INFO - 2015-11-23 14:05:11,196 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:05:11 INFO - 2015-11-23 14:05:11,196 DEBUG : BROWSER_OUTPUT: __metrics 14:05:11 INFO - 2015-11-23 14:05:11,312 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:05:12 INFO - 2015-11-23 14:05:12,570 INFO : Browser initialized. 14:05:12 INFO - 2015-11-23 14:05:12,571 INFO : Running cycle 1/1 for kraken test... 14:05:12 INFO - 2015-11-23 14:05:12,571 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn6jIN3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:05:24 INFO - 2015-11-23 14:05:24,490 DEBUG : BROWSER_OUTPUT: RSS: Main: 140566528 14:05:24 INFO - 2015-11-23 14:05:24,490 DEBUG : BROWSER_OUTPUT: 14:05:27 INFO - 2015-11-23 14:05:27,171 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34387/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34387/tests/kraken/driver.html?testName=audio-beat-detection) 14:05:27 INFO - 2015-11-23 14:05:27,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 177520640 14:05:27 INFO - 2015-11-23 14:05:27,759 DEBUG : BROWSER_OUTPUT: 14:05:30 INFO - 2015-11-23 14:05:30,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34387/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34387/tests/kraken/driver.html?testName=audio-dft) 14:05:30 INFO - 2015-11-23 14:05:30,984 DEBUG : BROWSER_OUTPUT: RSS: Main: 168534016 14:05:30 INFO - 2015-11-23 14:05:30,985 DEBUG : BROWSER_OUTPUT: 14:05:34 INFO - 2015-11-23 14:05:34,025 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34387/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34387/tests/kraken/driver.html?testName=audio-fft) 14:05:34 INFO - 2015-11-23 14:05:34,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 152309760 14:05:34 INFO - 2015-11-23 14:05:34,586 DEBUG : BROWSER_OUTPUT: 14:05:36 INFO - 2015-11-23 14:05:36,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34387/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34387/tests/kraken/driver.html?testName=audio-oscillator) 14:05:37 INFO - 2015-11-23 14:05:37,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 155746304 14:05:37 INFO - 2015-11-23 14:05:37,204 DEBUG : BROWSER_OUTPUT: 14:05:39 INFO - 2015-11-23 14:05:39,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34387/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34387/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:05:40 INFO - 2015-11-23 14:05:40,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 156192768 14:05:40 INFO - 2015-11-23 14:05:40,029 DEBUG : BROWSER_OUTPUT: 14:05:42 INFO - 2015-11-23 14:05:42,988 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34387/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34387/tests/kraken/driver.html?testName=imaging-darkroom) 14:05:43 INFO - 2015-11-23 14:05:43,569 DEBUG : BROWSER_OUTPUT: RSS: Main: 155873280 14:05:43 INFO - 2015-11-23 14:05:43,570 DEBUG : BROWSER_OUTPUT: 14:05:46 INFO - 2015-11-23 14:05:46,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34387/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34387/tests/kraken/driver.html?testName=imaging-desaturate) 14:05:47 INFO - 2015-11-23 14:05:47,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 157220864 14:05:47 INFO - 2015-11-23 14:05:47,559 DEBUG : BROWSER_OUTPUT: 14:05:50 INFO - 2015-11-23 14:05:50,379 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34387/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34387/tests/kraken/driver.html?testName=json-parse-financial) 14:05:50 INFO - 2015-11-23 14:05:50,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 156241920 14:05:50 INFO - 2015-11-23 14:05:50,961 DEBUG : BROWSER_OUTPUT: 14:05:52 INFO - 2015-11-23 14:05:52,751 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34387/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34387/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:05:53 INFO - 2015-11-23 14:05:53,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 164638720 14:05:53 INFO - 2015-11-23 14:05:53,320 DEBUG : BROWSER_OUTPUT: 14:05:55 INFO - 2015-11-23 14:05:55,159 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34387/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34387/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:05:55 INFO - 2015-11-23 14:05:55,753 DEBUG : BROWSER_OUTPUT: RSS: Main: 166436864 14:05:55 INFO - 2015-11-23 14:05:55,753 DEBUG : BROWSER_OUTPUT: 14:05:57 INFO - 2015-11-23 14:05:57,846 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34387/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34387/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:05:58 INFO - 2015-11-23 14:05:58,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 172310528 14:05:58 INFO - 2015-11-23 14:05:58,419 DEBUG : BROWSER_OUTPUT: 14:06:00 INFO - 2015-11-23 14:06:00,922 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34387/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34387/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:06:01 INFO - 2015-11-23 14:06:01,515 DEBUG : BROWSER_OUTPUT: RSS: Main: 180424704 14:06:01 INFO - 2015-11-23 14:06:01,515 DEBUG : BROWSER_OUTPUT: 14:06:04 INFO - 2015-11-23 14:06:04,110 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34387/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34387/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:06:04 INFO - 2015-11-23 14:06:04,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 178606080 14:06:04 INFO - 2015-11-23 14:06:04,679 DEBUG : BROWSER_OUTPUT: 14:06:06 INFO - 2015-11-23 14:06:06,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34387/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34387/tests/kraken/driver.html?testName=ai-astar) 14:06:06 INFO - 2015-11-23 14:06:06,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 238256128 14:06:06 INFO - 2015-11-23 14:06:06,686 DEBUG : BROWSER_OUTPUT: 14:06:06 INFO - 2015-11-23 14:06:06,686 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:06:06 INFO - 2015-11-23 14:06:06,687 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:06:06 INFO - 2015-11-23 14:06:06,687 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:06:06 INFO - 2015-11-23 14:06:06,687 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:06:06 INFO - 2015-11-23 14:06:06,687 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;115;109;114;113;115;102;113;113;106 14:06:06 INFO - 2015-11-23 14:06:06,687 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;129;157;163;129;149;149;132;164;131 14:06:06 INFO - 2015-11-23 14:06:06,687 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;159;160;161;164;161;161;161 14:06:06 INFO - 2015-11-23 14:06:06,687 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;81;97;73;72;72;120;87;71 14:06:06 INFO - 2015-11-23 14:06:06,687 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;133;94;95;95;136;96;94;128 14:06:06 INFO - 2015-11-23 14:06:06,688 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;109;109;109;109;109 14:06:06 INFO - 2015-11-23 14:06:06,688 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;147;147;147;147;147;147;147;147 14:06:06 INFO - 2015-11-23 14:06:06,688 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;96;96;96;96;95;95;96 14:06:06 INFO - 2015-11-23 14:06:06,688 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;71;71;72;71;73;72;79;70;69 14:06:06 INFO - 2015-11-23 14:06:06,688 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;68;68;67;67;68;69 14:06:06 INFO - 2015-11-23 14:06:06,688 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;82;86;81;81;82;82;83;83 14:06:06 INFO - 2015-11-23 14:06:06,688 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;121;120;121;129;122;120;126;125;123 14:06:06 INFO - 2015-11-23 14:06:06,688 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;151;150;148;142;136;148;159;151;136 14:06:06 INFO - 2015-11-23 14:06:06,689 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;69;70;69;68;68;69;69;69;69 14:06:06 INFO - 2015-11-23 14:06:06,689 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:06:06 INFO - 2015-11-23 14:06:06,689 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:06:06 INFO - 2015-11-23 14:06:06,689 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,985 14:06:06 INFO - 2015-11-23 14:06:06,689 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:06:06 INFO - 2015-11-23 14:06:06,689 DEBUG : BROWSER_OUTPUT: __startTimestamp1448316366681__endTimestamp 14:06:06 INFO - 2015-11-23 14:06:06,690 DEBUG : BROWSER_OUTPUT: 14:06:06 INFO - 2015-11-23 14:06:06,691 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:06:06 INFO - 2015-11-23 14:06:06,691 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:06:06 INFO - 2015-11-23 14:06:06,691 DEBUG : BROWSER_OUTPUT: 14:06:06 INFO - 2015-11-23 14:06:06,691 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.20 Median:113.00 stddev:4.26 (3.8%) stddev-sans-first:4.51 14:06:06 INFO - 2015-11-23 14:06:06,691 DEBUG : BROWSER_OUTPUT: Values: 112.0 115.0 109.0 114.0 113.0 115.0 102.0 113.0 113.0 106.0 14:06:06 INFO - 2015-11-23 14:06:06,691 DEBUG : BROWSER_OUTPUT: 14:06:06 INFO - 2015-11-23 14:06:06,691 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.70 Median:151.50 stddev:14.20 (9.4%) stddev-sans-first:14.74 14:06:06 INFO - 2015-11-23 14:06:06,692 DEBUG : BROWSER_OUTPUT: Values: 154.0 129.0 157.0 163.0 129.0 149.0 149.0 132.0 164.0 131.0 14:06:06 INFO - 2015-11-23 14:06:06,692 DEBUG : BROWSER_OUTPUT: 14:06:06 INFO - 2015-11-23 14:06:06,692 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.34 (0.8%) stddev-sans-first:1.39 14:06:06 INFO - 2015-11-23 14:06:06,692 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 159.0 160.0 161.0 164.0 161.0 161.0 161.0 14:06:06 INFO - 2015-11-23 14:06:06,692 DEBUG : BROWSER_OUTPUT: 14:06:06 INFO - 2015-11-23 14:06:06,692 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.70 Median:72.50 stddev:15.97 (22.0%) stddev-sans-first:16.55 14:06:06 INFO - 2015-11-23 14:06:06,692 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 81.0 97.0 73.0 72.0 72.0 120.0 87.0 71.0 14:06:06 INFO - 2015-11-23 14:06:06,692 DEBUG : BROWSER_OUTPUT: 14:06:06 INFO - 2015-11-23 14:06:06,692 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:94.50 stddev:18.28 (19.3%) stddev-sans-first:18.95 14:06:06 INFO - 2015-11-23 14:06:06,692 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 133.0 94.0 95.0 95.0 136.0 96.0 94.0 128.0 14:06:06 INFO - 2015-11-23 14:06:06,692 DEBUG : BROWSER_OUTPUT: 14:06:06 INFO - 2015-11-23 14:06:06,692 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:06:06 INFO - 2015-11-23 14:06:06,693 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 14:06:06 INFO - 2015-11-23 14:06:06,693 DEBUG : BROWSER_OUTPUT: 14:06:06 INFO - 2015-11-23 14:06:06,693 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 14:06:06 INFO - 2015-11-23 14:06:06,693 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 14:06:06 INFO - 2015-11-23 14:06:06,693 DEBUG : BROWSER_OUTPUT: 14:06:06 INFO - 2015-11-23 14:06:06,693 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 14:06:06 INFO - 2015-11-23 14:06:06,693 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 14:06:06 INFO - 2015-11-23 14:06:06,693 DEBUG : BROWSER_OUTPUT: 14:06:06 INFO - 2015-11-23 14:06:06,693 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.90 Median:71.50 stddev:2.73 (3.8%) stddev-sans-first:2.87 14:06:06 INFO - 2015-11-23 14:06:06,693 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 71.0 72.0 71.0 73.0 72.0 79.0 70.0 69.0 14:06:06 INFO - 2015-11-23 14:06:06,693 DEBUG : BROWSER_OUTPUT: 14:06:06 INFO - 2015-11-23 14:06:06,693 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 14:06:06 INFO - 2015-11-23 14:06:06,694 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 68.0 68.0 67.0 67.0 68.0 69.0 14:06:06 INFO - 2015-11-23 14:06:06,694 DEBUG : BROWSER_OUTPUT: 14:06:06 INFO - 2015-11-23 14:06:06,695 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:1.49 (1.8%) stddev-sans-first:1.51 14:06:06 INFO - 2015-11-23 14:06:06,695 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 82.0 86.0 81.0 81.0 82.0 82.0 83.0 83.0 14:06:06 INFO - 2015-11-23 14:06:06,695 DEBUG : BROWSER_OUTPUT: 14:06:06 INFO - 2015-11-23 14:06:06,695 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:124.00 stddev:3.31 (2.7%) stddev-sans-first:3.08 14:06:06 INFO - 2015-11-23 14:06:06,695 DEBUG : BROWSER_OUTPUT: Values: 128.0 121.0 120.0 121.0 129.0 122.0 120.0 126.0 125.0 123.0 14:06:06 INFO - 2015-11-23 14:06:06,695 DEBUG : BROWSER_OUTPUT: 14:06:06 INFO - 2015-11-23 14:06:06,695 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.10 Median:149.00 stddev:7.42 (5.0%) stddev-sans-first:7.53 14:06:06 INFO - 2015-11-23 14:06:06,695 DEBUG : BROWSER_OUTPUT: Values: 140.0 151.0 150.0 148.0 142.0 136.0 148.0 159.0 151.0 136.0 14:06:06 INFO - 2015-11-23 14:06:06,696 DEBUG : BROWSER_OUTPUT: 14:06:06 INFO - 2015-11-23 14:06:06,696 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 14:06:06 INFO - 2015-11-23 14:06:06,696 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 70.0 69.0 68.0 68.0 69.0 69.0 69.0 69.0 14:06:06 INFO - 2015-11-23 14:06:06,696 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:06:06 INFO - 2015-11-23 14:06:06,696 DEBUG : BROWSER_OUTPUT: 14:06:07 INFO - 2015-11-23 14:06:07,595 INFO : Browser exited with error code: 0 14:06:07 INFO - 2015-11-23 14:06:07,644 INFO : Completed test kraken (00:01:00) 14:06:07 INFO - 2015-11-23 14:06:07,644 INFO : Starting test v8_7 14:06:07 INFO - 2015-11-23 14:06:07,644 DEBUG : operating with platform_type : linux_ 14:06:07 INFO - 2015-11-23 14:06:07,644 INFO : Initialising browser for v8_7 test... 14:06:07 INFO - 2015-11-23 14:06:07,651 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpon1ZOA/profile http://localhost:34387/getInfo.html 14:06:11 INFO - 2015-11-23 14:06:11,693 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:06:11 INFO - 2015-11-23 14:06:11,693 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:06:11 INFO - 2015-11-23 14:06:11,693 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:06:11 INFO - 2015-11-23 14:06:11,693 DEBUG : BROWSER_OUTPUT: __metrics 14:06:11 INFO - 2015-11-23 14:06:11,829 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:06:13 INFO - 2015-11-23 14:06:13,070 INFO : Browser initialized. 14:06:13 INFO - 2015-11-23 14:06:13,071 INFO : Running cycle 1/1 for v8_7 test... 14:06:13 INFO - 2015-11-23 14:06:13,071 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpon1ZOA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:06:25 INFO - 2015-11-23 14:06:25,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 140779520 14:06:25 INFO - 2015-11-23 14:06:25,077 DEBUG : BROWSER_OUTPUT: 14:06:46 INFO - 2015-11-23 14:06:46,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34387/tests/v8_7/run.html (next: http://localhost:34387/tests/v8_7/run.html) 14:06:46 INFO - 2015-11-23 14:06:46,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 443625472 14:06:46 INFO - 2015-11-23 14:06:46,819 DEBUG : BROWSER_OUTPUT: 14:06:46 INFO - 2015-11-23 14:06:46,821 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:06:46 INFO - 2015-11-23 14:06:46,821 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:06:46 INFO - 2015-11-23 14:06:46,821 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:06:46 INFO - 2015-11-23 14:06:46,821 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:06:46 INFO - 2015-11-23 14:06:46,821 DEBUG : BROWSER_OUTPUT: |0;Richards;196.34792852935402 14:06:46 INFO - 2015-11-23 14:06:46,821 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.19680953296177 14:06:46 INFO - 2015-11-23 14:06:46,822 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.8622420524261 14:06:46 INFO - 2015-11-23 14:06:46,822 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5000 14:06:46 INFO - 2015-11-23 14:06:46,822 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1986.111111111111 14:06:46 INFO - 2015-11-23 14:06:46,822 DEBUG : BROWSER_OUTPUT: |5;Earley;803.370786516854 14:06:46 INFO - 2015-11-23 14:06:46,822 DEBUG : BROWSER_OUTPUT: |6;Boyer;12072.289156626506 14:06:46 INFO - 2015-11-23 14:06:46,822 DEBUG : BROWSER_OUTPUT: |7;RegExp;25794.871794871793 14:06:46 INFO - 2015-11-23 14:06:46,823 DEBUG : BROWSER_OUTPUT: |8;Splay;601.3229104028864 14:06:46 INFO - 2015-11-23 14:06:46,823 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 14:06:46 INFO - 2015-11-23 14:06:46,823 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:06:46 INFO - 2015-11-23 14:06:46,823 DEBUG : BROWSER_OUTPUT: __startTimestamp1448316406820__endTimestamp 14:06:46 INFO - 2015-11-23 14:06:46,823 DEBUG : BROWSER_OUTPUT: 14:06:46 INFO - 2015-11-23 14:06:46,824 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:06:46 INFO - 2015-11-23 14:06:46,824 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:06:46 INFO - 2015-11-23 14:06:46,824 DEBUG : BROWSER_OUTPUT: 14:06:46 INFO - 2015-11-23 14:06:46,824 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:196.35 Median:196.35 stddev:0.00 (0.0%) 14:06:46 INFO - 2015-11-23 14:06:46,824 DEBUG : BROWSER_OUTPUT: Values: 196.3 14:06:46 INFO - 2015-11-23 14:06:46,825 DEBUG : BROWSER_OUTPUT: 14:06:46 INFO - 2015-11-23 14:06:46,825 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.20 Median:192.20 stddev:0.00 (0.0%) 14:06:46 INFO - 2015-11-23 14:06:46,825 DEBUG : BROWSER_OUTPUT: Values: 192.2 14:06:46 INFO - 2015-11-23 14:06:46,825 DEBUG : BROWSER_OUTPUT: 14:06:46 INFO - 2015-11-23 14:06:46,825 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.86 Median:278.86 stddev:0.00 (0.0%) 14:06:46 INFO - 2015-11-23 14:06:46,825 DEBUG : BROWSER_OUTPUT: Values: 278.9 14:06:46 INFO - 2015-11-23 14:06:46,826 DEBUG : BROWSER_OUTPUT: 14:06:46 INFO - 2015-11-23 14:06:46,826 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5000.00 Median:5000.00 stddev:0.00 (0.0%) 14:06:46 INFO - 2015-11-23 14:06:46,826 DEBUG : BROWSER_OUTPUT: Values: 5000.0 14:06:46 INFO - 2015-11-23 14:06:46,826 DEBUG : BROWSER_OUTPUT: 14:06:46 INFO - 2015-11-23 14:06:46,826 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1986.11 Median:1986.11 stddev:0.00 (0.0%) 14:06:46 INFO - 2015-11-23 14:06:46,827 DEBUG : BROWSER_OUTPUT: Values: 1986.1 14:06:46 INFO - 2015-11-23 14:06:46,827 DEBUG : BROWSER_OUTPUT: 14:06:46 INFO - 2015-11-23 14:06:46,827 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:803.37 Median:803.37 stddev:0.00 (0.0%) 14:06:46 INFO - 2015-11-23 14:06:46,827 DEBUG : BROWSER_OUTPUT: Values: 803.4 14:06:46 INFO - 2015-11-23 14:06:46,828 DEBUG : BROWSER_OUTPUT: 14:06:46 INFO - 2015-11-23 14:06:46,828 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12072.29 Median:12072.29 stddev:0.00 (0.0%) 14:06:46 INFO - 2015-11-23 14:06:46,828 DEBUG : BROWSER_OUTPUT: Values: 12072.3 14:06:46 INFO - 2015-11-23 14:06:46,828 DEBUG : BROWSER_OUTPUT: 14:06:46 INFO - 2015-11-23 14:06:46,828 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25794.87 Median:25794.87 stddev:0.00 (0.0%) 14:06:46 INFO - 2015-11-23 14:06:46,829 DEBUG : BROWSER_OUTPUT: Values: 25794.9 14:06:46 INFO - 2015-11-23 14:06:46,829 DEBUG : BROWSER_OUTPUT: 14:06:46 INFO - 2015-11-23 14:06:46,829 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:601.32 Median:601.32 stddev:0.00 (0.0%) 14:06:46 INFO - 2015-11-23 14:06:46,829 DEBUG : BROWSER_OUTPUT: Values: 601.3 14:06:46 INFO - 2015-11-23 14:06:46,829 DEBUG : BROWSER_OUTPUT: 14:06:46 INFO - 2015-11-23 14:06:46,830 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 14:06:46 INFO - 2015-11-23 14:06:46,830 DEBUG : BROWSER_OUTPUT: Values: 4835.7 14:06:46 INFO - 2015-11-23 14:06:46,830 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:06:46 INFO - 2015-11-23 14:06:46,830 DEBUG : BROWSER_OUTPUT: 14:06:47 INFO - 2015-11-23 14:06:47,787 INFO : Browser exited with error code: 0 14:06:47 INFO - 2015-11-23 14:06:47,804 INFO : Completed test v8_7 (00:00:40) 14:06:48 INFO - 2015-11-23 14:06:48,278 INFO : Completed test suite (00:20:18) 14:06:48 INFO - 2015-11-23 14:06:48,278 DEBUG : Working with test: dromaeo_css 14:06:48 INFO - 2015-11-23 14:06:48,278 DEBUG : Generating results file: dromaeo_css 14:06:48 INFO - 2015-11-23 14:06:48,280 DEBUG : Working with test: kraken 14:06:48 INFO - 2015-11-23 14:06:48,280 DEBUG : Generating results file: kraken 14:06:48 INFO - 2015-11-23 14:06:48,280 INFO : javascript benchmark 14:06:48 INFO - 2015-11-23 14:06:48,280 DEBUG : Working with test: v8_7 14:06:48 INFO - 2015-11-23 14:06:48,280 DEBUG : Generating results file: v8_7 14:06:48 INFO - 2015-11-23 14:06:48,281 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:06:48 INFO - 2015-11-23 14:06:48,346 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 14:06:48 INFO - 2015-11-23 14:06:48,346 DEBUG : process_Request line: dromaeo_css 6168.27 graph.html#tests=[[72,203,35]] 14:06:48 INFO - 2015-11-23 14:06:48,346 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:06:48 INFO - 2015-11-23 14:06:48,385 DEBUG : process_Request line: kraken 1518.30 graph.html#tests=[[232,203,35]] 14:06:48 INFO - 2015-11-23 14:06:48,385 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:06:48 INFO - 2015-11-23 14:06:48,420 DEBUG : process_Request line: v8_7 19555.23 graph.html#tests=[[230,203,35]] 14:06:48 INFO - 2015-11-23 14:06:48,421 INFO : javascript benchmark 14:06:48 INFO - 2015-11-23 14:06:48,425 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2612.3730304726864, 2711.308616302844, 2727.904523341683, 2733.5489644208706, 2737.4935636907176, 4510.25580779171, 4610.308453731937, 4632.490426053136, 4656.324832899236, 4675.298705194223, 4609.838655647053, 4623.815047398109, 4708.128996135709, 4742.027884283722, 4744.478107408191, 4306.0414976583525, 4339.218940590692, 4352.281873490871, 4353.434053573031, 4378.036831896978, 4166.062635906912, 4350.956490435103, 4356.281213599768, 4398.054418300065, 4401.845935392262, 4213.30480470722, 4247.299195632748, 4278.72188307759, 4285.785710714452, 4310.849120280806, 4254.829806807724, 4270.359446083081, 4282.785860706952, 4287.0, 4299.355096735483, 4091.4067460218102, 4198.097409057037, 4219.43037689911, 4244.787760611988, 4285.35719642053, 4489.304157855538, 4570.954290457086, 4594.839180628695, 4617.792199351037, 4652.790624421909, 4933.950660493385, 4944.060628480577, 4945.950540494585, 4949.109160351135, 4965.851024469235, 4794.280857871312, 4900.950990490085, 4963.131451995886, 4978.800847966077, 5018.64869459138, 4598.977005114986, 4621.8151273949, 4661.114388266218, 4669.182892993713, 4723.905521889543, 5108.080545501845, 5122.436531981479, 5125.923111153335, 5136.666116702402, 5174.534291913746, 4690.132325519789, 4827.541383568555, 4915.336429582032, 4931.4821943696115, 4972.378452693413, 4886.657933944661, 4912.459629440758, 4940.086084074458, 4957.504249575014, 4989.850304490798, 4933.309336692866, 4996.750162491933, 4997.000599880039, 5002.149634562061, 5045.5459008689395, 4740.597049250852, 4828.95171048292, 4939.2838038484215, 4953.826616068421, 5004.3994720633755, 4064.5122585289955, 4109.301418758818, 4113.835446582163, 4138.420621113047, 4139.8965025874595, 3647.379945409287, 3656.5063716397945, 3666.6883314917995, 3666.688331491853, 3697.3159965406485, 4131.8967025824595, 4301.526832048535, 4309.159713855768, 4309.181255561433, 4347.174036932973, 4782.497837727058, 4818.518148185153, 4856.368672072608, 4865.8053677853195, 4867.756612169377, 4329.9134017319475, 4356.302991521405, 4365.257906155961, 4374.846880359172, 4405.581469760367, 4453.621442177451, 4457.5988161065015, 4460.0, 4460.955390446054, 4501.842435514807, 4535.6371490280035, 4636.258198688193, 4640.04878999811, 4789.592884604847, 4801.423829140455, 4863.319135321129, 4874.2201247800185, 4875.561199492063, 4878.975605122094, 4926.975365123295, 4762.761861906822, 4767.427908650984, 4769.856904292877, 4773.618110551217, 4804.8798780030775, 4699.060187962353, 4800.687955282895, 4804.279358096313, 4942.925856112233, 4997.125503037027, 4826.613870890391, 4914.680545764514, 4950.0, 4950.282209079735, 4970.9254361183885, 4803.255495398219, 4851.878703032311, 4865.197242454955, 4871.0501452217895, 4912.901741965212, 4697.953020469751, 4830.565249127595, 4831.903361932812, 4863.416390033219, 4892.437369702529, 4595.954040459686, 4672.159011377848, 4672.509386514367, 4672.7429991349445, 4677.46209185948, 4871.610271178368, 4920.778564964657, 4920.803167873245, 4923.236898280772, 4964.304997300309, 4539.069490754454, 4665.183592871302, 4799.040191961692, 4814.855554333376, 4817.8313759018265], "unit": "ms", "name": "dojo.html", "value": 4554.720853574472}, {"lowerIsBetter": false, "replicates": [534.9037173308806, 546.8250159948813, 570.9343425506066, 570.9714514274285, 575.3354875119236, 28022.0, 28636.0, 36608.63391366082, 37362.8131859341, 37505.249895002155, 39328.803355983255, 40121.79939100308, 40198.19603607926, 40206.597934020654, 40301.76077109972, 6851.931480685204, 7880.64537095832, 8042.0, 8042.034955805311, 8047.195280471965, 6989.930100698979, 7104.0, 7104.609246491441, 7105.573665580056, 10138.290319677626, 9921.35511191774, 10047.447390393525, 10050.64822731201, 10050.9497452513, 10061.748456288578, 9991.90008099917, 10109.39343639384, 10112.747181320452, 10114.241431892564, 10117.0, 7035.366816986496, 7223.169335526429, 9869.901300987041, 10076.596936122547, 10430.426326552037, 36421.27157456836, 36939.0, 36949.0, 36952.630473695455, 36985.26029479395, 2737.425140720451, 2783.067672329772, 2815.9155225343275, 3364.3775901458307, 3373.0, 27627.171184864485, 27996.720032799818, 28026.579601305995, 28262.717372826213, 28399.43201135966, 3147.5750773645723, 3204.3110731192905, 3278.672132786702, 3304.1244070321386, 3333.1667083229195, 222131.0, 224986.0, 225152.0, 225263.0, 225326.0, 45648.77175614101, 55099.0, 55406.445935540934, 55429.0, 55465.44534554603, 43435.74231932618, 43616.563834361885, 43618.78190609027, 62104.37895621076, 63389.0, 13486.0, 13706.794398084037, 13835.100718453268, 13849.792253116211, 13893.930530347283, 9672.322937394314, 9678.128968392879, 9686.418814871131, 9695.369800962915, 9700.951495242478, 18826.811731882506, 18864.811351886307, 19006.42980710553, 19051.0, 19054.714179287323, 7403.0, 7724.575148366894, 7806.843863122819, 7817.413693972975, 7920.207979202149, 836.602613758472, 917.8118485710547, 944.9102335278137, 994.6916455898695, 1049.9527521261562, 25765.3558661035, 25847.35381615437, 25931.611025834627, 26005.219843404728, 29148.0, 918.196577994255, 920.2224120618067, 924.8150369926042, 949.0414681172066, 1015.5937624950079, 15169.924150379178, 15806.525804225892, 16008.279627416794, 16038.198090095448, 16225.837741622669, 327946.0, 332232.0, 332277.0, 333613.0, 333696.0, 48432.75783621059, 48834.0, 48841.0, 48914.510854891705, 48942.37162726261, 1192.1416580062341, 1212.042486435706, 1224.2470880408484, 1224.8530176378713, 1227.404708716272, 26388.472230554897, 27409.31476713098, 27488.45023099487, 27773.583396249476, 27890.581641275803, 30038.549421758253, 30555.54166687457, 38968.6103138965, 43648.56351436445, 44474.332885007396, 209814.0, 210478.0, 212148.0, 212459.0, 212482.0, 22716.65925011093, 28087.859560702065, 28496.43007139887, 28650.856745716137, 28654.426911461236, 25637.23088307354, 28166.71833281723, 36844.63155368412, 37526.81236593799, 37569.4364584526, 37674.81162594279, 37689.0, 38949.6105038946, 39263.80368098256, 39424.0, 33210.5018424719, 33315.33369332648, 34119.65880341165, 34256.486152708225, 34278.48582271218, 34287.14282142966, 34893.127671808405, 34949.0, 34953.47569786404, 34999.12502187466, 30128.548071778503, 30204.24489387695, 30567.23581910381, 31211.531827023067, 31255.84372078125, 23582.17462388808, 23789.167379141647, 23931.65795143001, 24010.87994560086, 24227.273181804576], "unit": "ms", "name": "ext.html", "value": 17097.356944636584}, {"lowerIsBetter": false, "replicates": [314.75291895861756, 329.1081170029221, 334.1395905543227, 336.04227950341516, 338.72732450377447, 12034.699132521691, 12219.694507637314, 15015.624609384771, 15533.378664853406, 15735.527934161964, 12433.254004759721, 12472.438740256688, 12544.937275313634, 14563.563093107225, 15270.923645381758, 4530.569595888385, 4630.189716799563, 4646.953530464702, 4676.672632915697, 4887.364642596457, 3338.2155193529625, 3463.393906066441, 4977.825776097838, 5164.406093299281, 5167.974160129194, 5083.567896728782, 5105.489451054883, 5110.718910459923, 5144.56271216947, 5148.073346797575, 5054.1407960646775, 5101.081805275067, 5171.974140129275, 5173.068847607429, 5176.456472070416, 4975.950240497585, 4977.178765503688, 4988.052270068675, 4996.125678006334, 4996.300517927493, 18417.723734143998, 18812.24751009958, 19130.139143738565, 19133.1390087445, 19277.22891084355, 1790.910454477284, 1802.0809387212485, 1825.9269629214816, 1851.9074046297767, 1857.7492038574755, 8758.649654013832, 8865.867011994826, 8976.820463590757, 8980.55097245135, 9140.6800761973, 1730.0935319443781, 1737.8435940765391, 1744.7350670763722, 1803.6753384390804, 1836.0819590204896, 52292.73853630746, 53316.20025699618, 54476.0, 55875.0, 56891.715541422025, 9698.418094914328, 9717.61129554824, 9768.902310976799, 9770.169535589412, 9785.412875227508, 12384.256944583354, 12443.25340479556, 12445.004399648007, 12462.0, 12477.812832807514, 6711.832204194837, 6836.5214434989075, 6943.756968506078, 6983.615901125487, 7037.155541334971, 6705.966470167618, 6709.161354830646, 6710.563813352116, 6751.324867513209, 6781.389674929182, 4135.60711732385, 4138.710290279711, 4149.3775933609595, 4165.0, 4181.686373521998, 1578.2661062605944, 1630.600502876779, 1653.3717187468926, 1663.8003439587328, 1701.9404320848712, 364.3932851801773, 366.1870647163293, 377.98488060477274, 824.7360844529812, 868.0928429790883, 9193.678221262357, 9266.814663706687, 9326.160645541933, 9465.858012129824, 9536.2371010319, 377.6318089862417, 381.4526154967575, 399.4387885021549, 408.30384194947544, 409.14080431094465, 5096.541311282002, 5506.339239291311, 5576.832695019156, 9247.907520924704, 9771.51142442875, 469986.0, 479249.0, 483484.0, 485538.0, 486224.0, 68210.0, 69475.65262173656, 69670.0, 71855.0, 72125.2787472129, 1057.5505410200633, 1066.168388656849, 1073.4900922061959, 1074.4949873559415, 1075.3386667199773, 14639.560813175622, 14643.633909152357, 14655.85344146545, 14885.0, 15125.39498420051, 31845.36309273848, 32266.0, 32291.838540807144, 32395.676043240208, 32408.83795581007, 43268.56731432645, 43702.12595748131, 43801.34297985469, 43837.0, 46459.0, 8836.469811811312, 8971.327150463872, 8978.102189781232, 8994.190522852974, 9059.954700226457, 15166.24168791578, 15204.087754734752, 15511.224438778241, 15867.444639437565, 16039.919800400923, 12954.417051232529, 13087.476500939856, 13243.66890827737, 13265.336733163496, 13444.932775336061, 12797.0, 12962.935185324013, 13100.737985240432, 13449.731005380034, 13476.663083422993, 13181.340932953506, 13437.596872093853, 13738.725225495235, 13850.0, 13997.930010349883, 7307.7807665770115, 7534.585597792174, 8586.871196931927, 8670.82658346817, 9026.68406605792, 9350.25197984146, 9392.060793920553, 12962.870371296167, 13581.592552223448, 13619.727605448034], "unit": "ms", "name": "jquery.html", "value": 7667.273011273559}, {"lowerIsBetter": false, "replicates": [1341.9463221471142, 1346.1788309131434, 1390.7635701930672, 1528.5490780219834, 1600.471844291384, 5903.704814759261, 6418.871622567546, 6550.082988381619, 6550.410463058324, 6566.901496477551, 6570.113034740309, 6685.130932978706, 6689.130413046297, 6695.598264104157, 6700.3299670032975, 2059.6910463430495, 2077.356019633911, 2079.6984437256588, 2081.698153767703, 2081.8334533237303, 2058.4133521946246, 2059.258666879922, 2091.7908209179113, 2119.2688522459725, 2122.9999999999923, 2006.6388050150968, 2026.7669218039894, 2038.0828627117783, 2041.5304479969616, 2041.5508588110592, 2070.2029718558315, 2078.0856423173905, 2079.854410191287, 2082.312836763864, 2082.6980087887246, 2053.2813515269686, 2067.3487851326786, 2073.9585208295903, 2074.5850829833944, 2083.7082808406835, 5611.2144299798065, 5718.656880587178, 6750.054992301082, 6771.93228067718, 6796.35434633709, 3858.6913046956456, 4008.118213992946, 4012.8996775080564, 4015.156817068419, 4031.7984100794843, 2665.333666583354, 2666.7599916007457, 2693.824901381404, 2733.4669739400824, 2733.7539621434166, 886.5965985476593, 898.9280857531381, 912.3066469483174, 913.2739472119681, 914.0950459045564, 8957.507337096456, 8971.820563588692, 9018.954905225497, 9022.18800307969, 9048.230900373475, 3798.525184351956, 3810.8285127169343, 3857.1707082977296, 3863.362545180014, 3865.1883104547796, 7938.0, 7947.483413578215, 7956.2441568050945, 7956.801079973047, 7976.322012628875, 4210.115875666144, 4214.388913607571, 4221.5778422158155, 4222.535521092677, 4228.112096459717, 3821.082940094357, 3821.808909554511, 3823.0824602095295, 3825.5600605930117, 3827.0623697194364, 3111.7510599152015, 3133.8903138390046, 3148.5434611981136, 3175.1903264667826, 3178.030700636328, 1006.0442579549457, 1019.1490105761624, 1025.620520407439, 1034.7723500829804, 1038.9896101039044, 1089.6513115803025, 1105.563302495526, 1106.7399161197113, 1107.734143805481, 1161.517970042423, 6357.332480089616, 6407.839804004844, 6409.775657851953, 6412.454941330039, 6416.262129855127, 1054.2356791326226, 1077.3893029920318, 1096.4353358020626, 1110.9777804444027, 1124.6288724720823, 4517.164324599959, 5087.669301495391, 5136.666116702402, 5203.973980130075, 5204.557612602971, 7431.331180193701, 7825.295723384809, 8082.110967793538, 8131.308838748772, 8143.470674406145, 7987.16134805837, 8022.358211343078, 8026.438149329608, 8026.478278911852, 8046.879296810553, 6162.845928851814, 6468.15913931186, 6477.611343319416, 6481.48148148147, 6504.577202481823, 6456.677166141768, 6473.546851720523, 6487.124238227779, 6496.447801936699, 6503.642299673564, 7258.165310989304, 7374.446916481178, 7460.179380268058, 7469.402447804054, 7472.252774722484, 7400.407967362706, 7626.313631773167, 7632.0, 7658.846823063619, 7683.116441609286, 5691.288588926384, 5699.202111704281, 5705.429457054262, 5765.91351129725, 5768.6538807669995, 6554.63949482783, 6626.469882409492, 6641.800745977628, 6650.334966503505, 6657.901446261312, 6105.48103411215, 6200.534959877937, 6232.065190221503, 6345.555811093363, 6378.776742814165, 6144.600600960924, 6168.629882207082, 6184.474319682698, 6241.063840423973, 6269.905951410641, 6276.089966954674, 6312.5265605078885, 6318.526110541636, 6335.303116657072, 6338.90491642635, 5780.0, 5807.157962095388, 5820.185174075717, 5831.7375718091935, 5832.883342333044, 5865.589408741347, 5900.822975310747, 5934.406559344204, 5942.019566771607, 5944.108383742473], "unit": "ms", "name": "mootools.html", "value": 3977.409856225715}, {"lowerIsBetter": false, "replicates": [304.922244827569, 309.3056089080015, 312.36745590179885, 317.09153275864657, 318.50472515238823, 5379.327584051994, 5409.8106566270135, 5485.286912701353, 5494.560435165187, 5512.6968016759065, 5377.516023557879, 5389.892202155955, 5390.056740070491, 5402.702851343174, 5406.459354064592, 3946.0923987482897, 4075.9592404076025, 4224.683148763839, 4229.344451610005, 4236.872893813183, 4067.837286508536, 4151.543330233671, 4167.729097608646, 4172.666186705072, 4176.582341765814, 4117.75293482392, 4119.073208528072, 4120.505539335284, 4127.669786417095, 4136.31750761124, 3936.6457018868296, 4037.0916543777416, 4038.6567141792984, 4121.587841215869, 4134.37984302354, 3654.049947013769, 3662.6520480554573, 3664.3404187246283, 3671.284099600579, 3672.265546890633, 5148.3564554430695, 5156.123459011977, 5157.123289040872, 5157.30376399185, 5165.845024649229, 4797.856064318076, 4809.0862736080035, 4812.470628230892, 4812.807487700487, 4825.203841366206, 5531.170324451325, 5655.660660360391, 5663.292088488939, 5668.4614961579, 5678.119891416795, 4057.3305404608204, 4067.2068946555432, 4075.2257071156682, 4080.10237747695, 4082.346824508094, 5958.523318134538, 5961.582689211757, 5966.075258334965, 5970.34326224115, 5976.013957696975, 4200.1179752251755, 4206.0, 4211.052513184509, 4217.493900731932, 4218.093109981307, 4193.224253513049, 4246.426732391149, 4281.207976524353, 4282.678799090018, 4300.1399720056115, 4787.521247875185, 4793.49668284832, 4827.662063655511, 4834.854954351375, 4839.322494850724, 5616.1856530803625, 5642.0, 5671.914921276184, 5673.461021202979, 5677.971610141923, 1491.0084793612343, 1507.3443052272296, 1508.8113985751781, 1509.7207016701946, 1510.5921401221608, 1038.6883934819523, 1043.4261156363968, 1045.2421994054403, 1061.6125114333213, 1069.5668254356997, 5007.39911210657, 5011.949880501221, 5011.997600479918, 5012.47369026247, 5017.197248440232, 5898.528117750569, 5898.587098903122, 5900.0, 5904.822855314347, 5911.674857882857, 4975.353204083518, 4991.951690145038, 5010.3737032870895, 5014.749262536931, 5018.397792264952, 2933.2080338308538, 2988.581598576201, 3130.1705048162257, 3132.060381885425, 3162.8418579070953, 5549.250851135126, 5635.070213414822, 5637.49262566371, 5642.971785141131, 5648.068068768689, 6107.694615269219, 6111.449969502766, 6115.807417553623, 6122.081687746784, 6137.723802428902, 5621.297337832771, 5628.549716022709, 5630.155476678449, 5633.183188437735, 5635.98552260597, 5833.708314584169, 5935.317438494456, 5975.37258587842, 5975.7012149391485, 5979.3123790762875, 5815.389384114607, 5816.651000939957, 5822.0, 5825.825225243249, 5834.066549352084, 5620.072688006433, 5626.493615574618, 5628.212050312877, 5628.718564071862, 5642.294713160855, 4177.540470548298, 4269.594388533084, 4273.572642735701, 4276.037891474393, 4283.957160428356, 5948.137520059654, 5952.672603006876, 5952.672603006876, 5957.523398128053, 5961.165436838759, 5729.570282228933, 5740.856478587902, 5741.799037033684, 5746.942530574808, 5749.655020698771, 5653.802116925888, 5706.2011318414625, 5716.085426331767, 5722.828315150552, 5731.083026715705, 5382.4886635769535, 5521.503064724194, 5531.391546929915, 5598.188262701967, 5606.299212598426, 5752.68360240174, 5786.045302525036, 5790.739416726173, 5796.82609521715, 5800.651960882361, 5412.675239485643, 5490.91763623538, 5549.1676248563035, 5549.223108764695, 5556.499915007668], "unit": "ms", "name": "prototype.html", "value": 4300.444681102282}, {"lowerIsBetter": false, "replicates": [635.5106567942682, 640.849400390908, 666.9995007488767, 707.8336590901138, 772.7449941519295, 10921.617743378984, 11246.325220486757, 11248.0, 11253.66239012829, 11261.155413343991, 11345.886541134587, 11433.599824006162, 11507.942460287686, 11531.48108335125, 12903.54837580685, 760.118262815136, 776.1036003416064, 776.2005134711256, 777.2848978939361, 777.5606782168085, 619.5446346934999, 625.1185827982546, 626.5801912718467, 762.2301475509747, 777.8677624803797, 794.043177970547, 801.7594721583531, 809.465752603282, 810.6635746165334, 811.1645005644195, 633.550179372646, 799.436397339874, 799.588212070784, 800.6477150053958, 800.6917336825335, 472.7494427953156, 577.1314172170898, 587.6562211106508, 590.0529649911873, 590.0706387439757, 11803.704907377298, 12006.879931200663, 12009.819852702216, 12031.819522707166, 12035.759284814254, 10258.846117308247, 10638.308509946828, 10806.459677016197, 11006.559737610485, 11070.667879963534, 8790.692325768567, 8806.515641639708, 8937.6871809487, 8977.147171018743, 9014.278857691435, 3145.433821912055, 3228.757843161772, 3229.5963004624423, 3244.513323001545, 3246.6753324667343, 41821.091518224646, 41869.581304186875, 42319.1536169278, 42329.365059524134, 42406.0, 8876.556172191365, 8892.822143557221, 9070.047644997181, 9173.174414302744, 9265.7954465919, 15175.696486070217, 15202.087874727551, 15213.467528636445, 15225.0, 15225.923870380799, 5895.882082358415, 6140.201773769381, 6217.098520714561, 6321.778737744157, 6543.01854721786, 3519.436890097572, 3575.535180426528, 3629.6007439181667, 3654.926901462009, 3710.962890371116, 2501.287133167075, 2514.7862431693147, 2519.9748002520105, 2522.709888362825, 2526.456811785475, 466.20512026993896, 471.25541644202764, 485.7085748550841, 490.11778798163874, 490.65899200056333, 423.3564981228515, 449.1062785057712, 460.66831881045596, 472.29156265601597, 500.6670564074922, 6892.793216203522, 6924.549904256207, 6937.791866244021, 6976.965115174392, 6986.720531178696, 419.3290734824318, 473.8649484896788, 479.5204795204795, 499.4306490600718, 500.37453183520597, 3272.754543409254, 3361.3949489092197, 3437.5359326491102, 3573.7855728656364, 3632.146445585285, 53327.20009199865, 53382.0, 53442.73278633582, 53478.46521534813, 53538.73230633822, 43047.35428968568, 43499.78250108729, 43534.34698479525, 43574.56425435768, 45937.540624593996, 36912.0, 37390.439143413416, 37455.81272093622, 37514.81242593769, 37671.0, 7346.7061317546695, 7360.368316084935, 7468.626568671436, 7646.749013723423, 7695.538267703956, 32673.509897351083, 32736.181595460304, 33436.33127337488, 33511.66488335085, 33655.326893461504, 38921.0, 38962.6103738959, 42633.0, 42764.0, 43016.569834301255, 8817.250533704708, 8892.555372231493, 8909.331800115147, 9209.585568649292, 9668.75828104303, 10598.364098154136, 10790.0, 10932.289401188897, 11005.61480348184, 11204.439778010903, 8704.78238044054, 8747.212750852454, 8914.465132092095, 8968.71229312419, 9209.355345125778, 9056.230220431336, 9083.318751093562, 9235.907640923504, 9311.767205819639, 9350.345475816628, 8058.355331573577, 8653.35099867525, 9436.669716560162, 9480.715578532656, 9594.232461402931, 8071.677132914618, 8126.715564955198, 8136.593170341341, 8183.63173657175, 8191.426600137933, 7583.2416758325935, 7985.480943738638, 8023.879641805494, 8079.919200808152, 8192.959035205024], "unit": "ms", "name": "yui.html", "value": 5392.501166472375}], "name": "dromaeo_css", "value": 6168.272429222206}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 115.0, 109.0, 114.0, 113.0, 115.0, 102.0, 113.0, 113.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [154.0, 129.0, 157.0, 163.0, 129.0, 149.0, 149.0, 132.0, 164.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 159.0, 160.0, 161.0, 164.0, 161.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 81.0, 97.0, 73.0, 72.0, 72.0, 120.0, 87.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 133.0, 94.0, 95.0, 95.0, 136.0, 96.0, 94.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 72.0, 71.0, 73.0, 72.0, 79.0, 70.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 67.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 82.0, 86.0, 81.0, 81.0, 82.0, 82.0, 83.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [128.0, 121.0, 120.0, 121.0, 129.0, 122.0, 120.0, 126.0, 125.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.5}, {"lowerIsBetter": true, "replicates": [140.0, 151.0, 150.0, 148.0, 142.0, 136.0, 148.0, 159.0, 151.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.1}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 70.0, 69.0, 68.0, 68.0, 69.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1518.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [196.34792852935402], "unit": "score", "name": "Richards", "value": 179.79308599999996}, {"lowerIsBetter": false, "replicates": [192.19680953296177], "unit": "score", "name": "DeltaBlue", "value": 344.01195399999983}, {"lowerIsBetter": false, "replicates": [278.8622420524261], "unit": "score", "name": "Encrypt", "value": 954.525066}, {"lowerIsBetter": false, "replicates": [5000.0], "unit": "score", "name": "Decrypt", "value": 53.23619999999997}, {"lowerIsBetter": false, "replicates": [1986.111111111111], "unit": "score", "name": "RayTrace", "value": 372.5818741258742}, {"lowerIsBetter": false, "replicates": [803.370786516854], "unit": "score", "name": "Earley", "value": 829.5833146853149}, {"lowerIsBetter": false, "replicates": [12072.289156626506], "unit": "score", "name": "Boyer", "value": 55.20601696606782}, {"lowerIsBetter": false, "replicates": [25794.871794871793], "unit": "score", "name": "RegExp", "value": 35.31651590457257}, {"lowerIsBetter": false, "replicates": [601.3229104028864], "unit": "score", "name": "Splay", "value": 135.519533}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19555.229243949572}]} 14:06:48 INFO - RETURN: dromaeo_css: 6168.27 14:06:48 INFO - RETURN: kraken: 1518.30 14:06:48 INFO - RETURN: v8_7: 19555.23 14:06:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19555.23"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1518.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6168.27"}}} 14:06:48 INFO - Return code: 0 14:06:48 INFO - # TBPL SUCCESS # 14:06:48 INFO - Running post-action listener: _resource_record_post_action 14:06:48 INFO - Running post-run listener: _resource_record_post_run 14:06:49 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 519004160; Read time: 4; Write time: 388632 14:06:49 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 227491840; Read time: 0; Write time: 213224 14:06:49 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 278675456; Read time: 0; Write time: 153416 14:06:49 INFO - Running post-run listener: _upload_blobber_files 14:06:49 INFO - Blob upload gear active. 14:06:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:06:49 INFO - Copying logs to upload dir... 14:06:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1262.534559 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-23 14:06:49.339678) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 14:06:49.344819) ========= 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=61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010002 build_url: 'https://queue.taskcluster.net/v1/task/LuCeZxBaTqan9p46v13KiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 14:06:49.374431) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 14:06:49.375043) ========= 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=61fa6ed41387771909ec0f71000001b3-1448315144.852828-100122653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004635 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 14:06:49.426001) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 14:06:49.426310) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 14:06:49.426823) ========= ========= Total master_lag: 0.22 =========