builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1448331633.35 results: success (0) buildid: 20151123180231 builduid: 2bb2bf33cb334e6e8a902aacffaca018 revision: 0ed0b39c35419af45b20bf9b1df70104be2f7914 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.348179) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.348716) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.349009) ========= 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=820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006381 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.414294) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.414876) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.471170) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.471517) ========= 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=820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.522733) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.522992) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.523327) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.523608) ========= 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=820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 18:20:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 230M=0s 2015-11-23 18:20:34 (230 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.258467 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.796242) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.796521) ========= 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=820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.151426 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.960481) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.960770) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0ed0b39c35419af45b20bf9b1df70104be2f7914 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 0ed0b39c35419af45b20bf9b1df70104be2f7914 --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=820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 18:20:34,372 truncating revision to first 12 chars 2015-11-23 18:20:34,372 Setting DEBUG logging. 2015-11-23 18:20:34,372 attempt 1/10 2015-11-23 18:20:34,372 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0ed0b39c3541?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 18:20:34,628 unpacking tar archive at: fx-team-0ed0b39c3541/testing/mozharness/ program finished with exit code 0 elapsedTime=0.533436 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:34.505626) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:34.505918) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:34.515425) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:34.515671) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:34.516028) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-11-23 18:20:34.516530) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:20:35 INFO - MultiFileLogger online at 20151123 18:20:35 in /builds/slave/test 18:20:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 18:20:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:20:35 INFO - {'append_to_log': False, 18:20:35 INFO - 'base_work_dir': '/builds/slave/test', 18:20:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:20:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:20:35 INFO - 'branch': 'Fx-Team-Non-PGO', 18:20:35 INFO - 'buildbot_json_path': 'buildprops.json', 18:20:35 INFO - 'config_files': ('talos/linux_config.py',), 18:20:35 INFO - 'default_actions': ('clobber', 18:20:35 INFO - 'read-buildbot-config', 18:20:35 INFO - 'download-and-extract', 18:20:35 INFO - 'populate-webroot', 18:20:35 INFO - 'create-virtualenv', 18:20:35 INFO - 'install', 18:20:35 INFO - 'run-tests'), 18:20:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:20:35 INFO - 'download_minidump_stackwalk': True, 18:20:35 INFO - 'download_symbols': 'ondemand', 18:20:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:20:35 INFO - 'tooltool.py': '/tools/tooltool.py', 18:20:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:20:35 INFO - '/tools/misc-python/virtualenv.py')}, 18:20:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:20:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:20:35 INFO - 'installer_path': 'installer.exe', 18:20:35 INFO - 'log_level': 'info', 18:20:35 INFO - 'log_name': 'talos', 18:20:35 INFO - 'log_to_console': True, 18:20:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:20:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:20:35 INFO - 'opt_config_files': (), 18:20:35 INFO - 'pip_index': False, 18:20:35 INFO - 'sps_profile': False, 18:20:35 INFO - 'sps_profile_interval': 0, 18:20:35 INFO - 'suite': 'dromaeojs', 18:20:35 INFO - 'system_bits': '64', 18:20:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:20:35 INFO - 'title': 'talos-linux64-ix-055', 18:20:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:20:35 INFO - 'use_talos_json': True, 18:20:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:20:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:20:35 INFO - 'work_dir': 'build'} 18:20:35 INFO - ##### 18:20:35 INFO - ##### Running clobber step. 18:20:35 INFO - ##### 18:20:35 INFO - Running pre-action listener: _resource_record_pre_action 18:20:35 INFO - Running main action method: clobber 18:20:35 INFO - rmtree: /builds/slave/test/build 18:20:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:20:35 INFO - Running post-action listener: _resource_record_post_action 18:20:35 INFO - ##### 18:20:35 INFO - ##### Running read-buildbot-config step. 18:20:35 INFO - ##### 18:20:35 INFO - Running pre-action listener: _resource_record_pre_action 18:20:35 INFO - Running main action method: read_buildbot_config 18:20:35 INFO - Using buildbot properties: 18:20:35 INFO - { 18:20:35 INFO - "properties": { 18:20:35 INFO - "buildnumber": 911, 18:20:35 INFO - "product": "firefox", 18:20:35 INFO - "script_repo_revision": "production", 18:20:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:20:35 INFO - "repository": "", 18:20:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:20:35 INFO - "buildid": "20151123180231", 18:20:35 INFO - "slavename": "talos-linux64-ix-055", 18:20:35 INFO - "pgo_build": "False", 18:20:35 INFO - "basedir": "/builds/slave/test", 18:20:35 INFO - "project": "", 18:20:35 INFO - "platform": "ubuntu64_hw", 18:20:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:20:35 INFO - "slavebuilddir": "test", 18:20:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:20:35 INFO - "branch": "fx-team", 18:20:35 INFO - "repo_path": "integration/fx-team", 18:20:35 INFO - "stage_platform": "linux64", 18:20:35 INFO - "builduid": "2bb2bf33cb334e6e8a902aacffaca018", 18:20:35 INFO - "revision": "0ed0b39c35419af45b20bf9b1df70104be2f7914" 18:20:35 INFO - }, 18:20:35 INFO - "sourcestamp": { 18:20:35 INFO - "repository": "", 18:20:35 INFO - "hasPatch": false, 18:20:35 INFO - "project": "", 18:20:35 INFO - "branch": "fx-team-linux64-talos", 18:20:35 INFO - "changes": [ 18:20:35 INFO - { 18:20:35 INFO - "category": null, 18:20:35 INFO - "files": [ 18:20:35 INFO - { 18:20:35 INFO - "url": null, 18:20:35 INFO - "name": "https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:20:35 INFO - } 18:20:35 INFO - ], 18:20:35 INFO - "repository": "", 18:20:35 INFO - "rev": "0ed0b39c35419af45b20bf9b1df70104be2f7914", 18:20:35 INFO - "who": "felipc@gmail.com", 18:20:35 INFO - "when": 1448331580, 18:20:35 INFO - "number": 6698465, 18:20:35 INFO - "comments": "Bug 1226487 - Enable e10s checks for accessibility on Beta. r=mconley", 18:20:35 INFO - "project": "", 18:20:35 INFO - "at": "Mon 23 Nov 2015 18:19:40", 18:20:35 INFO - "branch": "fx-team-linux64-talos", 18:20:35 INFO - "revlink": "", 18:20:35 INFO - "properties": [ 18:20:35 INFO - [ 18:20:35 INFO - "buildid", 18:20:35 INFO - "20151123180231", 18:20:35 INFO - "Change" 18:20:35 INFO - ], 18:20:35 INFO - [ 18:20:35 INFO - "builduid", 18:20:35 INFO - "2bb2bf33cb334e6e8a902aacffaca018", 18:20:35 INFO - "Change" 18:20:35 INFO - ], 18:20:35 INFO - [ 18:20:35 INFO - "pgo_build", 18:20:35 INFO - "False", 18:20:35 INFO - "Change" 18:20:35 INFO - ] 18:20:35 INFO - ], 18:20:35 INFO - "revision": "0ed0b39c35419af45b20bf9b1df70104be2f7914" 18:20:35 INFO - } 18:20:35 INFO - ], 18:20:35 INFO - "revision": "0ed0b39c35419af45b20bf9b1df70104be2f7914" 18:20:35 INFO - } 18:20:35 INFO - } 18:20:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:20:35 INFO - Running post-action listener: _resource_record_post_action 18:20:35 INFO - ##### 18:20:35 INFO - ##### Running download-and-extract step. 18:20:35 INFO - ##### 18:20:35 INFO - Running pre-action listener: _resource_record_pre_action 18:20:35 INFO - Running main action method: download_and_extract 18:20:35 INFO - mkdir: /builds/slave/test/build/tests 18:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:35 INFO - https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:20:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/test_packages.json 18:20:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/test_packages.json 18:20:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:20:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:20:38 INFO - Downloaded 1302 bytes. 18:20:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:20:38 INFO - Using the following test package requirements: 18:20:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:20:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:20:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:38 INFO - u'jsshell-linux-x86_64.zip'], 18:20:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:20:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:20:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:20:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:20:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:20:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:20:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:20:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:38 INFO - https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:20:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:20:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:20:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:20:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:20:39 INFO - Downloaded 21341655 bytes. 18:20:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:20:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:20:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:20:40 INFO - Return code: 0 18:20:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:40 INFO - https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:20:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:20:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:20:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:20:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:20:49 INFO - Downloaded 21341655 bytes. 18:20:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:20:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:20:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:20:51 INFO - Return code: 0 18:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:51 INFO - https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:20:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:20:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:20:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:20:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:20:52 INFO - Downloaded 11130997 bytes. 18:20:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 18:20:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:20:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:20:53 INFO - Return code: 0 18:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:53 INFO - https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:20:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:20:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:20:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:20:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:20:54 INFO - Downloaded 56069436 bytes. 18:20:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:20:54 INFO - mkdir: /builds/slave/test/properties 18:20:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:20:54 INFO - Writing to file /builds/slave/test/properties/build_url 18:20:54 INFO - Contents: 18:20:54 INFO - build_url:https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:20:54 INFO - Running post-action listener: _resource_record_post_action 18:20:54 INFO - Running post-action listener: set_extra_try_arguments 18:20:54 INFO - ##### 18:20:54 INFO - ##### Running populate-webroot step. 18:20:54 INFO - ##### 18:20:54 INFO - Running pre-action listener: _resource_record_pre_action 18:20:54 INFO - Running main action method: populate_webroot 18:20:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:20:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:20:54 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:20:54 INFO - '../fennec_ids.txt'], 18:20:54 INFO - 'tests': ['tcheck2']}, 18:20:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:20:54 INFO - '--tppagecycles', 18:20:54 INFO - '7'], 18:20:54 INFO - 'tests': ['tsvgm']}}, 18:20:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:20:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:20:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:20:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:20:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:20:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:20:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:20:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:54 INFO - 'talos_options': ['--e10s'], 18:20:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:20:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:54 INFO - 'tests': ['damp', 'tps']}, 18:20:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:54 INFO - 'talos_options': ['--e10s'], 18:20:54 INFO - 'tests': ['damp', 'tps']}, 18:20:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:20:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:20:54 INFO - 'other': {'tests': ['a11yr', 18:20:54 INFO - 'ts_paint', 18:20:54 INFO - 'tpaint', 18:20:54 INFO - 'sessionrestore', 18:20:54 INFO - 'sessionrestore_no_auto_restore']}, 18:20:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:20:54 INFO - 'tests': ['a11yr', 18:20:54 INFO - 'ts_paint', 18:20:54 INFO - 'tpaint', 18:20:54 INFO - 'sessionrestore', 18:20:54 INFO - 'sessionrestore_no_auto_restore']}, 18:20:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:20:54 INFO - 'tests': ['a11yr', 18:20:54 INFO - 'ts_paint', 18:20:54 INFO - 'tpaint', 18:20:54 INFO - 'sessionrestore', 18:20:54 INFO - 'sessionrestore_no_auto_restore']}, 18:20:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:20:54 INFO - 'tests': ['a11yr', 18:20:54 INFO - 'ts_paint', 18:20:54 INFO - 'tpaint', 18:20:54 INFO - 'sessionrestore', 18:20:54 INFO - 'sessionrestore_no_auto_restore']}, 18:20:54 INFO - 'other_l64': {'tests': ['a11yr', 18:20:54 INFO - 'ts_paint', 18:20:54 INFO - 'tpaint', 18:20:54 INFO - 'sessionrestore', 18:20:54 INFO - 'sessionrestore_no_auto_restore']}, 18:20:54 INFO - 'other_nol64': {'tests': ['a11yr', 18:20:54 INFO - 'ts_paint', 18:20:54 INFO - 'tpaint', 18:20:54 INFO - 'sessionrestore', 18:20:54 INFO - 'sessionrestore_no_auto_restore']}, 18:20:54 INFO - 'svgr': {'tests': ['tsvgx', 18:20:54 INFO - 'tsvgr_opacity', 18:20:54 INFO - 'tart', 18:20:54 INFO - 'tscrollx', 18:20:54 INFO - 'cart']}, 18:20:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:20:54 INFO - 'tests': ['tsvgx', 18:20:54 INFO - 'tsvgr_opacity', 18:20:54 INFO - 'tart', 18:20:54 INFO - 'tscrollx', 18:20:54 INFO - 'cart']}, 18:20:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:54 INFO - 'tests': ['tp5o']}, 18:20:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:54 INFO - 'talos_options': ['--e10s'], 18:20:54 INFO - 'tests': ['tp5o']}, 18:20:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:54 INFO - 'talos_options': ['--xperf_path', 18:20:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:20:54 INFO - 'tests': ['tp5n']}, 18:20:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:54 INFO - 'talos_options': ['--e10s', 18:20:54 INFO - '--xperf_path', 18:20:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:20:54 INFO - 'tests': ['tp5n']}}, 18:20:54 INFO - 'talos.zip': {'path': '', 18:20:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:20:54 INFO - Running post-action listener: _resource_record_post_action 18:20:54 INFO - ##### 18:20:54 INFO - ##### Running create-virtualenv step. 18:20:54 INFO - ##### 18:20:54 INFO - Running pre-action listener: _resource_record_pre_action 18:20:54 INFO - Running main action method: create_virtualenv 18:20:54 INFO - Creating virtualenv /builds/slave/test/build/venv 18:20:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:20:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:20:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:20:55 INFO - Using real prefix '/usr' 18:20:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:20:56 INFO - Installing distribute.............................................................................................................................................................................................done. 18:20:58 INFO - Installing pip.................done. 18:20:58 INFO - Return code: 0 18:20:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83cab92c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x163f900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1685b70>, '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 0x16d6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d7250>, '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': '820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:20:58 INFO - Using env: {'DISPLAY': ':0', 18:20:58 INFO - 'HOME': '/home/cltbld', 18:20:58 INFO - 'LANG': 'en_US.UTF-8', 18:20:58 INFO - 'LANGUAGE': 'en_US:en', 18:20:58 INFO - 'LOGNAME': 'cltbld', 18:20:58 INFO - 'MAIL': '/var/mail/cltbld', 18:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:58 INFO - 'MOZ_NO_REMOTE': '1', 18:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:58 INFO - 'NO_EM_RESTART': '1', 18:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:58 INFO - 'PWD': '/builds/slave/test', 18:20:58 INFO - 'SHELL': '/bin/bash', 18:20:58 INFO - 'SHLVL': '1', 18:20:58 INFO - 'TERM': 'linux', 18:20:58 INFO - 'TMOUT': '86400', 18:20:58 INFO - 'USER': 'cltbld', 18:20:58 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176', 18:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:58 INFO - '_': '/tools/buildbot/bin/python'} 18:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:20:58 INFO - Cleaning up... 18:20:58 INFO - Return code: 0 18:20:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f83cab92c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x163f900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1685b70>, '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 0x16d6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d7250>, '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': '820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:20:58 INFO - Using env: {'DISPLAY': ':0', 18:20:58 INFO - 'HOME': '/home/cltbld', 18:20:58 INFO - 'LANG': 'en_US.UTF-8', 18:20:58 INFO - 'LANGUAGE': 'en_US:en', 18:20:58 INFO - 'LOGNAME': 'cltbld', 18:20:58 INFO - 'MAIL': '/var/mail/cltbld', 18:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:58 INFO - 'MOZ_NO_REMOTE': '1', 18:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:58 INFO - 'NO_EM_RESTART': '1', 18:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:58 INFO - 'PWD': '/builds/slave/test', 18:20:58 INFO - 'SHELL': '/bin/bash', 18:20:58 INFO - 'SHLVL': '1', 18:20:58 INFO - 'TERM': 'linux', 18:20:58 INFO - 'TMOUT': '86400', 18:20:58 INFO - 'USER': 'cltbld', 18:20:58 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176', 18:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:58 INFO - '_': '/tools/buildbot/bin/python'} 18:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:58 INFO - Downloading/unpacking psutil>=0.7.1 18:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:00 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:21:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:21:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:21:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:21:00 INFO - Installing collected packages: psutil 18:21:00 INFO - Running setup.py install for psutil 18:21:00 INFO - building 'psutil._psutil_linux' extension 18:21:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:21:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:21:01 INFO - building 'psutil._psutil_posix' extension 18:21:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:21: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 18:21:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:21:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:21:02 INFO - Successfully installed psutil 18:21:02 INFO - Cleaning up... 18:21:02 INFO - Return code: 0 18:21:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:02 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 0x7f83cab92c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x163f900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1685b70>, '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 0x16d6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d7250>, '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': '820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:21:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:21:02 INFO - Using env: {'DISPLAY': ':0', 18:21:02 INFO - 'HOME': '/home/cltbld', 18:21:02 INFO - 'LANG': 'en_US.UTF-8', 18:21:02 INFO - 'LANGUAGE': 'en_US:en', 18:21:02 INFO - 'LOGNAME': 'cltbld', 18:21:02 INFO - 'MAIL': '/var/mail/cltbld', 18:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:02 INFO - 'MOZ_NO_REMOTE': '1', 18:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:02 INFO - 'NO_EM_RESTART': '1', 18:21:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:02 INFO - 'PWD': '/builds/slave/test', 18:21:02 INFO - 'SHELL': '/bin/bash', 18:21:02 INFO - 'SHLVL': '1', 18:21:02 INFO - 'TERM': 'linux', 18:21:02 INFO - 'TMOUT': '86400', 18:21:02 INFO - 'USER': 'cltbld', 18:21:02 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176', 18:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:02 INFO - '_': '/tools/buildbot/bin/python'} 18:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:21:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:21:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:21: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) 18:21:04 INFO - Installing collected packages: mozsystemmonitor 18:21:04 INFO - Running setup.py install for mozsystemmonitor 18:21:04 INFO - Successfully installed mozsystemmonitor 18:21:04 INFO - Cleaning up... 18:21:04 INFO - Return code: 0 18:21:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f83cab92c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x163f900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1685b70>, '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 0x16d6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d7250>, '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': '820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:21:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:21:04 INFO - Using env: {'DISPLAY': ':0', 18:21:04 INFO - 'HOME': '/home/cltbld', 18:21:04 INFO - 'LANG': 'en_US.UTF-8', 18:21:04 INFO - 'LANGUAGE': 'en_US:en', 18:21:04 INFO - 'LOGNAME': 'cltbld', 18:21:04 INFO - 'MAIL': '/var/mail/cltbld', 18:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:04 INFO - 'MOZ_NO_REMOTE': '1', 18:21:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:04 INFO - 'NO_EM_RESTART': '1', 18:21:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:04 INFO - 'PWD': '/builds/slave/test', 18:21:04 INFO - 'SHELL': '/bin/bash', 18:21:04 INFO - 'SHLVL': '1', 18:21:04 INFO - 'TERM': 'linux', 18:21:04 INFO - 'TMOUT': '86400', 18:21:04 INFO - 'USER': 'cltbld', 18:21:04 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176', 18:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:04 INFO - '_': '/tools/buildbot/bin/python'} 18:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:04 INFO - Downloading/unpacking blobuploader==1.2.4 18:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:06 INFO - Downloading blobuploader-1.2.4.tar.gz 18:21:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:21:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:21:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:07 INFO - Downloading docopt-0.6.1.tar.gz 18:21:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:21:07 INFO - Installing collected packages: blobuploader, requests, docopt 18:21:07 INFO - Running setup.py install for blobuploader 18:21:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:21:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:21:07 INFO - Running setup.py install for requests 18:21:07 INFO - Running setup.py install for docopt 18:21:07 INFO - Successfully installed blobuploader requests docopt 18:21:07 INFO - Cleaning up... 18:21:07 INFO - Return code: 0 18:21:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:07 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 0x7f83cab92c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x163f900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1685b70>, '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 0x16d6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d7250>, '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': '820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:21:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:21:07 INFO - Using env: {'DISPLAY': ':0', 18:21:07 INFO - 'HOME': '/home/cltbld', 18:21:07 INFO - 'LANG': 'en_US.UTF-8', 18:21:07 INFO - 'LANGUAGE': 'en_US:en', 18:21:07 INFO - 'LOGNAME': 'cltbld', 18:21:07 INFO - 'MAIL': '/var/mail/cltbld', 18:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:07 INFO - 'MOZ_NO_REMOTE': '1', 18:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:07 INFO - 'NO_EM_RESTART': '1', 18:21:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:07 INFO - 'PWD': '/builds/slave/test', 18:21:07 INFO - 'SHELL': '/bin/bash', 18:21:07 INFO - 'SHLVL': '1', 18:21:07 INFO - 'TERM': 'linux', 18:21:07 INFO - 'TMOUT': '86400', 18:21:07 INFO - 'USER': 'cltbld', 18:21:07 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176', 18:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:07 INFO - '_': '/tools/buildbot/bin/python'} 18:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:21:08 INFO - Running setup.py (path:/tmp/pip-k4TfG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:21:08 INFO - Running setup.py (path:/tmp/pip-GFJ70U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:21:08 INFO - Running setup.py (path:/tmp/pip-ROBXKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:21:08 INFO - Running setup.py (path:/tmp/pip-ngJgOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:21:08 INFO - Running setup.py (path:/tmp/pip-9GjRs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:21:08 INFO - Running setup.py (path:/tmp/pip-qEO4cx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:21:08 INFO - Running setup.py (path:/tmp/pip-wmH8TN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:21:08 INFO - Running setup.py (path:/tmp/pip-ghPtOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:21:08 INFO - Running setup.py (path:/tmp/pip-eTyjlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:21:08 INFO - Running setup.py (path:/tmp/pip-Dwb_3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:21:08 INFO - Running setup.py (path:/tmp/pip-jqYckR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:21:08 INFO - Running setup.py (path:/tmp/pip-K3NOV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:21:08 INFO - Running setup.py (path:/tmp/pip-dys2gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:21:09 INFO - Running setup.py (path:/tmp/pip-8PDI9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:09 INFO - Running setup.py (path:/tmp/pip-PZZqtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:21:09 INFO - Running setup.py (path:/tmp/pip-A2sApN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:21:09 INFO - Running setup.py (path:/tmp/pip-DZsQgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:21:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:21:09 INFO - Running setup.py install for manifestparser 18:21:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:21:09 INFO - Running setup.py install for mozcrash 18:21:09 INFO - Running setup.py install for mozdebug 18:21:09 INFO - Running setup.py install for mozdevice 18:21:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:21:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:21:09 INFO - Running setup.py install for mozfile 18:21:09 INFO - Running setup.py install for mozhttpd 18:21:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:21:09 INFO - Running setup.py install for mozinfo 18:21:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:21:09 INFO - Running setup.py install for mozInstall 18:21:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:21:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:21:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:21:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:21:10 INFO - Running setup.py install for mozleak 18:21:10 INFO - Running setup.py install for mozlog 18:21:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:21:10 INFO - Running setup.py install for moznetwork 18:21:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:21:10 INFO - Running setup.py install for mozprocess 18:21:10 INFO - Running setup.py install for mozprofile 18:21:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:21:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:21:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:21:10 INFO - Running setup.py install for mozrunner 18:21:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:21:10 INFO - Running setup.py install for mozscreenshot 18:21:10 INFO - Running setup.py install for moztest 18:21:10 INFO - Running setup.py install for mozversion 18:21:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:21:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:21:11 INFO - Cleaning up... 18:21:11 INFO - Return code: 0 18:21:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21: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')]} 18:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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')]} 18:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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 0x7f83cab92c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x163f900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1685b70>, '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 0x16d6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d7250>, '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': '820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:21: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 18:21: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 18:21:11 INFO - Using env: {'DISPLAY': ':0', 18:21:11 INFO - 'HOME': '/home/cltbld', 18:21:11 INFO - 'LANG': 'en_US.UTF-8', 18:21:11 INFO - 'LANGUAGE': 'en_US:en', 18:21:11 INFO - 'LOGNAME': 'cltbld', 18:21:11 INFO - 'MAIL': '/var/mail/cltbld', 18:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:11 INFO - 'MOZ_NO_REMOTE': '1', 18:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:11 INFO - 'NO_EM_RESTART': '1', 18:21:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:11 INFO - 'PWD': '/builds/slave/test', 18:21:11 INFO - 'SHELL': '/bin/bash', 18:21:11 INFO - 'SHLVL': '1', 18:21:11 INFO - 'TERM': 'linux', 18:21:11 INFO - 'TMOUT': '86400', 18:21:11 INFO - 'USER': 'cltbld', 18:21:11 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176', 18:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:11 INFO - '_': '/tools/buildbot/bin/python'} 18:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:21:11 INFO - Running setup.py (path:/tmp/pip-dr13uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:21: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)) 18:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:21:11 INFO - Running setup.py (path:/tmp/pip-Fj_kHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:21: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)) 18:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:21:11 INFO - Running setup.py (path:/tmp/pip-ToqMXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:21:11 INFO - Running setup.py (path:/tmp/pip-1PLcpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:21:11 INFO - Running setup.py (path:/tmp/pip-OEYfUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:21:11 INFO - Running setup.py (path:/tmp/pip-ObkTu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:21:11 INFO - Running setup.py (path:/tmp/pip-KaXIoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:21:11 INFO - Running setup.py (path:/tmp/pip-48KzUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:21:11 INFO - Running setup.py (path:/tmp/pip-S8sBDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:21:11 INFO - Running setup.py (path:/tmp/pip-LxPQVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:21:11 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)) 18:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:21:11 INFO - Running setup.py (path:/tmp/pip-ALrgR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:21: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)) 18:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:21:12 INFO - Running setup.py (path:/tmp/pip-qJoQ5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:21: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)) 18:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:21:12 INFO - Running setup.py (path:/tmp/pip-bLG8f2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:21: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)) 18:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:21:12 INFO - Running setup.py (path:/tmp/pip-QXL7_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:21: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)) 18:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:12 INFO - Running setup.py (path:/tmp/pip-OL2Jjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:21: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)) 18:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:21:12 INFO - Running setup.py (path:/tmp/pip-6kjwZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:21: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)) 18:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:21:12 INFO - Running setup.py (path:/tmp/pip-Qj8Ob3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:21:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:14 INFO - Downloading blessings-1.5.1.tar.gz 18:21: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 18:21:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:21:14 INFO - Installing collected packages: blessings 18:21:14 INFO - Running setup.py install for blessings 18:21:14 INFO - Successfully installed blessings 18:21:14 INFO - Cleaning up... 18:21:14 INFO - Return code: 0 18:21:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:21:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:21:14 INFO - Reading from file tmpfile_stdout 18:21:14 INFO - Current package versions: 18:21:14 INFO - argparse == 1.2.1 18:21:14 INFO - blessings == 1.5.1 18:21:14 INFO - blobuploader == 1.2.4 18:21:14 INFO - docopt == 0.6.1 18:21:14 INFO - manifestparser == 1.1 18:21:14 INFO - mozInstall == 1.12 18:21:14 INFO - mozcrash == 0.16 18:21:14 INFO - mozdebug == 0.1 18:21:14 INFO - mozdevice == 0.47 18:21:14 INFO - mozfile == 1.2 18:21:14 INFO - mozhttpd == 0.7 18:21:14 INFO - mozinfo == 0.9 18:21:14 INFO - mozleak == 0.1 18:21:14 INFO - mozlog == 3.1 18:21:14 INFO - moznetwork == 0.27 18:21:14 INFO - mozprocess == 0.22 18:21:14 INFO - mozprofile == 0.27 18:21:14 INFO - mozrunner == 6.11 18:21:14 INFO - mozscreenshot == 0.1 18:21:14 INFO - mozsystemmonitor == 0.0 18:21:14 INFO - moztest == 0.7 18:21:14 INFO - mozversion == 1.4 18:21:14 INFO - psutil == 3.1.1 18:21:14 INFO - requests == 1.2.3 18:21:14 INFO - wsgiref == 0.1.2 18:21:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f83cab92c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x163f900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1685b70>, '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 0x16d6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d7250>, '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': '820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:21:14 INFO - Using env: {'DISPLAY': ':0', 18:21:14 INFO - 'HOME': '/home/cltbld', 18:21:14 INFO - 'LANG': 'en_US.UTF-8', 18:21:14 INFO - 'LANGUAGE': 'en_US:en', 18:21:14 INFO - 'LOGNAME': 'cltbld', 18:21:14 INFO - 'MAIL': '/var/mail/cltbld', 18:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:14 INFO - 'MOZ_NO_REMOTE': '1', 18:21:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:14 INFO - 'NO_EM_RESTART': '1', 18:21:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:14 INFO - 'PWD': '/builds/slave/test', 18:21:14 INFO - 'SHELL': '/bin/bash', 18:21:14 INFO - 'SHLVL': '1', 18:21:14 INFO - 'TERM': 'linux', 18:21:14 INFO - 'TMOUT': '86400', 18:21:14 INFO - 'USER': 'cltbld', 18:21:14 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176', 18:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:14 INFO - '_': '/tools/buildbot/bin/python'} 18:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:21:14 INFO - Cleaning up... 18:21:14 INFO - Return code: 0 18:21:14 INFO - Running post-action listener: _resource_record_post_action 18:21:14 INFO - Running post-action listener: _start_resource_monitoring 18:21:14 INFO - Starting resource monitoring. 18:21:14 INFO - ##### 18:21:14 INFO - ##### Running install step. 18:21:14 INFO - ##### 18:21:14 INFO - Running pre-action listener: _resource_record_pre_action 18:21:14 INFO - Running main action method: install 18:21:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:21:15 INFO - Reading from file tmpfile_stdout 18:21:15 INFO - Detecting whether we're running mozinstall >=1.0... 18:21:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:21:15 INFO - Reading from file tmpfile_stdout 18:21:15 INFO - Output received: 18:21:15 INFO - Usage: mozinstall [options] installer 18:21:15 INFO - Options: 18:21:15 INFO - -h, --help show this help message and exit 18:21:15 INFO - -d DEST, --destination=DEST 18:21:15 INFO - Directory to install application into. [default: 18:21:15 INFO - "/builds/slave/test"] 18:21:15 INFO - --app=APP Application being installed. [default: firefox] 18:21:15 INFO - mkdir: /builds/slave/test/build/application 18:21: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'] 18:21: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 18:21:29 INFO - Reading from file tmpfile_stdout 18:21:29 INFO - Output received: 18:21:29 INFO - /builds/slave/test/build/application/firefox/firefox 18:21:29 INFO - Running post-action listener: _resource_record_post_action 18:21:29 INFO - ##### 18:21:29 INFO - ##### Running run-tests step. 18:21:29 INFO - ##### 18:21:29 INFO - Running pre-action listener: _resource_record_pre_action 18:21:29 INFO - Running main action method: run_tests 18:21:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:21:29 INFO - Python 2.7.3 18:21:29 INFO - Return code: 0 18:21:29 INFO - grabbing minidump binary from tooltool 18:21: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')]} 18:21: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 0x1685b70>, '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 0x16d6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d7250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:21: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 18:21: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 18:21:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:21:29 INFO - Return code: 0 18:21:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:21:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:21:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:21:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:21:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:21:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] in /builds/slave/test/build 18:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost 18:21:29 INFO - Using env: {'DISPLAY': ':0', 18:21:29 INFO - 'HOME': '/home/cltbld', 18:21:29 INFO - 'LANG': 'en_US.UTF-8', 18:21:29 INFO - 'LANGUAGE': 'en_US:en', 18:21:29 INFO - 'LOGNAME': 'cltbld', 18:21:29 INFO - 'MAIL': '/var/mail/cltbld', 18:21:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:21:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:29 INFO - 'MOZ_NO_REMOTE': '1', 18:21:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:29 INFO - 'NO_EM_RESTART': '1', 18:21:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:29 INFO - 'PWD': '/builds/slave/test', 18:21:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:21:29 INFO - 'SHELL': '/bin/bash', 18:21:29 INFO - 'SHLVL': '1', 18:21:29 INFO - 'TERM': 'linux', 18:21:29 INFO - 'TMOUT': '86400', 18:21:29 INFO - 'USER': 'cltbld', 18:21:29 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176', 18:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:29 INFO - '_': '/tools/buildbot/bin/python'} 18:21:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] with output_timeout 3600 18:21:29 INFO - mozversion INFO | application_buildid: 20151123180231 18:21:29 INFO - mozversion INFO | application_changeset: 0ed0b39c35419af45b20bf9b1df70104be2f7914 18:21:29 INFO - mozversion INFO | application_display_name: Nightly 18:21:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:21:29 INFO - mozversion INFO | application_name: Firefox 18:21:29 INFO - mozversion INFO | application_remotingname: firefox 18:21:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 18:21:29 INFO - mozversion INFO | application_vendor: Mozilla 18:21:29 INFO - mozversion INFO | application_version: 45.0a1 18:21:29 INFO - mozversion INFO | platform_buildid: 20151123180231 18:21:29 INFO - mozversion INFO | platform_changeset: 0ed0b39c35419af45b20bf9b1df70104be2f7914 18:21:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 18:21:29 INFO - mozversion INFO | platform_version: 45.0a1 18:21:29 INFO - 2015-11-23 18:21:29,686 DEBUG : using testdate: 1448331689 18:21:29 INFO - 2015-11-23 18:21:29,686 DEBUG : actual date: 1448331689 18:21:29 INFO - 2015-11-23 18:21:29,733 INFO : starting webserver on 'localhost:49550' 18:21:29 INFO - 2015-11-23 18:21:29,734 INFO : Starting test suite talos-linux64-ix-055 18:21:29 INFO - 2015-11-23 18:21:29,734 INFO : Starting test dromaeo_css 18:21:29 INFO - 2015-11-23 18:21:29,734 DEBUG : operating with platform_type : linux_ 18:21:29 INFO - 2015-11-23 18:21:29,735 INFO : Initialising browser for dromaeo_css test... 18:21:29 INFO - 2015-11-23 18:21:29,752 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplnkGbO/profile http://localhost:49550/getInfo.html 18:21:35 INFO - 2015-11-23 18:21:35,755 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:21:35 INFO - 2015-11-23 18:21:35,755 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:21:35 INFO - 2015-11-23 18:21:35,755 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:21:35 INFO - 2015-11-23 18:21:35,755 DEBUG : BROWSER_OUTPUT: __metrics 18:21:35 INFO - 2015-11-23 18:21:35,892 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:21:37 INFO - 2015-11-23 18:21:37,122 INFO : Browser initialized. 18:21:37 INFO - 2015-11-23 18:21:37,123 INFO : Running cycle 1/1 for dromaeo_css test... 18:21:37 INFO - 2015-11-23 18:21:37,123 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplnkGbO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:21:49 INFO - 2015-11-23 18:21:49,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 140689408 18:21:49 INFO - 2015-11-23 18:21:49,026 DEBUG : BROWSER_OUTPUT: 18:22:40 INFO - 2015-11-23 18:22:40,185 DEBUG : BROWSER_OUTPUT: 1448331760184 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:24:52 INFO - 2015-11-23 18:24:52,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49550/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49550/tests/dromaeo/cssquery-ext.html) 18:24:53 INFO - 2015-11-23 18:24:53,380 DEBUG : BROWSER_OUTPUT: RSS: Main: 215773184 18:24:53 INFO - 2015-11-23 18:24:53,380 DEBUG : BROWSER_OUTPUT: 18:27:55 INFO - 2015-11-23 18:27:55,887 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49550/tests/dromaeo/cssquery-ext.html (next: http://localhost:49550/tests/dromaeo/cssquery-jquery.html) 18:27:56 INFO - 2015-11-23 18:27:56,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 218087424 18:27:56 INFO - 2015-11-23 18:27:56,453 DEBUG : BROWSER_OUTPUT: 18:30:58 INFO - 2015-11-23 18:30:58,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49550/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49550/tests/dromaeo/cssquery-mootools.html) 18:30:59 INFO - 2015-11-23 18:30:59,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 219676672 18:30:59 INFO - 2015-11-23 18:30:59,139 DEBUG : BROWSER_OUTPUT: 18:34:01 INFO - 2015-11-23 18:34:01,125 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49550/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49550/tests/dromaeo/cssquery-prototype.html) 18:34:01 INFO - 2015-11-23 18:34:01,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 202903552 18:34:01 INFO - 2015-11-23 18:34:01,711 DEBUG : BROWSER_OUTPUT: 18:37:04 INFO - 2015-11-23 18:37:04,556 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49550/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49550/tests/dromaeo/cssquery-yui.html) 18:37:05 INFO - 2015-11-23 18:37:05,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 206573568 18:37:05 INFO - 2015-11-23 18:37:05,145 DEBUG : BROWSER_OUTPUT: 18:40:07 INFO - 2015-11-23 18:40:07,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49550/tests/dromaeo/cssquery-yui.html (next: http://localhost:49550/tests/dromaeo/cssquery-dojo.html) 18:40:08 INFO - 2015-11-23 18:40:08,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 251523072 18:40:08 INFO - 2015-11-23 18:40:08,121 DEBUG : BROWSER_OUTPUT: 18:40:08 INFO - 2015-11-23 18:40:08,121 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:40:08 INFO - 2015-11-23 18:40:08,121 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:40:08 INFO - 2015-11-23 18:40:08,121 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:40:08 INFO - 2015-11-23 18:40:08,121 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:40:08 INFO - 2015-11-23 18:40:08,121 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2607.674040744907;2677.2503698964297;2683.6377089092966;2693.0305090167535;2694.0974773450894;4456.866294011184;4605.055963527478;4608.562186592277;4672.0889426561835;4692.38998930139;4598.885027874305;4603.7928293226805;4645.117427688737;4654.790534425951;4715.434147902257;4272.978635106828;4320.308750599905;4326.58897404746;4341.913161736763;4414.09511050234;4375.628071613901;4411.867643970686;4426.645868330525;4431.8670439886855;4451.821927122911;4144.357624568182;4200.642945349649;4247.936280955788;4256.851010214627;4282.935755963663;4286.742795432284;4292.678049146295;4333.4366532350905;4343.847965321199;4385.254506733863;4280.2081614901035;4284.592963668447;4291.957080429218;4293.184294983975;4329.328954012133;4394.6923715339935;4515.977420112911;4528.139653465864;4535.954640453586;4598.609118224921;4948.925766113475;4956.504349565051;4963.875903102451;4972.7513624319;4999.375078115236;4963.900721985576;4975.477574854624;4984.0281145176705;4984.327115839352;5021.57316628087;4485.170243504962;4607.0785842831565;4607.3089036644105;4623.630109591191;4630.8147674093;4935.407751069823;5005.674631149037;5012.67417617861;5014.247862820534;5049.697018178921;4896.094222568836;4911.68074075184;4912.238603016538;4915.3855768029;4960.479149689303;4788.688735232199;4967.105920934194;4973.502649734997;4977.90044199114;4986.650934434555;4802.73584952831;4830.516948305141;4851;4854.781534830941;4862.51374862518;4760.976195119002;4810.965642386904;4834.709917404967;4836.347093142451;4864.635152363587;4107.116969851496;4161.500619925629;4162.62536371728;4189.748615083044;4205.642520385741;3522.2075033117344;3627.9637203628154;3635.654612811779;3643.908902277464;3671.632836716307;4208.9789551052045;4219.97890010548;4274.957250427518;4282.785860707015;4318.827246910151;4961.975190124099;4966;4971.130052240844;4973.577245934136;5015.122353588107;4105.0763578194665;4195.8741237762915;4279.507856596469;4291.163223171452;4326.329418940069;4278.957210427918;4352.717073390219;4355.934660980088;4367.47590289161;4368.803403846835;4656.068786242765;4673.088747694167;4704.200285951465;4720.197566413649;4759.904801903943;4937.654364194472;4940.086084074458;4956.578690811177;4979.302897594267;4991.550760431433;4525.162844873709;4695.835645752382;4708.693934894221;4717.150912835723;4842.104210721028;4916.950830491649;4917.778699958439;4920.557149856387;4929.5809856161195;4972.328735620645;5010.7745151469;5029.597632189343;5030.8239211627415;5031.195008798721;5061.9493805061475;4616.238320677051;4683.555062269079;4719.2921061841;4719.764011799328;4784.210605250095;4757.048590281888;4777.784999674954;4779.832705855279;4783.7129772213775;4818.397700287464;4685.484596694293;4700.059988002482;4707.529247075402;4751.477337492804;4752.477227505041;4555.749433781041;4705.176594095951;4705.223638099676;4765.714057156443;4884.169691152583;4672.883177920579;4727.929081063856;4731.763411829326;4732.810687572459;4778.689385189951 18:40:08 INFO - 2015-11-23 18:40:08,122 DEBUG : BROWSER_OUTPUT: |1;ext.html;540.8377486753975;549.9340079190498;565.6153815405523;569.7037540478951;574.6954114319412;28121.859390703044;28611;36528.26943461133;37446.812765936134;37532.43701344475;40418;40694;40757.59242407575;40763.59236407635;40771.59228407715;6993.685284162199;7816.921830781676;7979.401544884128;7988.600569971507;8005.559694216816;7078.575285482862;7163.391111755507;7169.85660286794;7177.6770045348085;9729.513524323791;9871.555779989882;9984.45085520296;9994.800103997915;9996.400215987027;10002.799944001152;9954.552045157949;10067.345622534585;10067.748306292327;10074.445905475195;10076.294659373847;7122.394596459256;7305.853882922312;10061.496925153713;10453.68638940833;10457.84313235302;36910.077248069014;37242;37259.25481490355;37277.06807329811;37372.43941340882;2401.615741481372;2410.240774156135;2439.7194322652945;2525.4317778499876;2543.860087695176;27481.587776183373;27982.160535183975;28114.156575302775;28146.71853281482;28513;3396.813175275359;3538.982305088484;3539.50446937429;3549.5917969433585;3666.0651533858695;222304;223620;224050;224580;224752;44605;45857;56215.43784562184;56605.71697141488;56619.433805661414;58839.41160588425;59809;60015.39984600098;60082.09876851851;60093.69953150206;14006.579802605938;14191.71616567663;14201.147931123958;14224.21766802815;14225.502107426191;10761.677149685522;10837.512311945982;10848.891511084947;10850.67447976562;10868.61959831402;18726;19007.80992190088;19057.237710491703;19161.32935347256;19166.520836978907;7365.300296471826;7852.371810255166;7860.6855725771475;7906.248906353887;7912.36701063925;844.3709436469746;882.2633101360436;908.0102688070035;985.5417230987625;1032.0762917189224;25433.237002889942;25738.613920791202;25760.8711956439;26018;26173.607395889077;948.3645957208687;951.3388195204267;980.9656662016795;1051.7896420715736;1114.2089116727052;14860.554183374516;15290.847091528942;15300.311485983157;15394.535584680541;15935.442259520862;332530;336143;337408;337582;338093;48960.26559601609;49416.25875611797;49446.50553494419;49550.50449495531;49570.50429495731;1203.9879601204052;1217.7686239614445;1222.480445810527;1222.5354365341113;1233.5805826019196;26664.133510654843;26805.731942680322;27378.178654640393;27593.586096208976;27742;38948.221035578565;39435.21129577335;39480.01299967524;39488;39499.60500395074;242427;243650;243706;244145;244326;23755.52488950177;24045.27864164078;27929.301767455978;28653.713462865937;29189.85405072961;33316.1670958228;33656.32687346288;44321;44703;45401;33945.151371215914;34252.828735856165;34299.485507716905;34402.48396274108;34911.65088349084;33952.320953581286;34484.137896552784;34516.30967380588;34535.136621584665;36880;30712.53931190989;32519.349613008082;34603.826980864935;34868.65131348654;37506;29259;30986.225344366572;31244;31252.687473125887;31298.843505782326;23504;23656.763432366144;23682.38816677732;23888.28335149948;23985.28044158678 18:40:08 INFO - 2015-11-23 18:40:08,124 DEBUG : BROWSER_OUTPUT: |2;jquery.html;319.9072269041978;332.58925227344224;333.2036432925307;336.25519474364296;339.1216748621071;12429.378531073433;12840.22958622481;14971.700565988687;15482.84517154828;15820.288087036097;9378.484183369912;9678.709638710832;9682.177014953737;12351.629451116458;13134.868651313507;4616.492185859561;4735.644826637998;4739.0758802033615;4746.264329029006;4748.548887855648;3324.2188085799817;4650.488446270908;4789.784459699322;5299.390570084432;5308.9469105308835;5238.711870847121;5243.947560524384;5260.316158899338;5260.894782104356;5286.233496143057;5228.372595288552;5348.224507446418;5579.9163012554845;5588.077967135418;5588.245586845785;4922.926156107661;4923.950760492421;4926.33494478248;4934.358533390672;4936.136176169192;17915.462536123938;18042.548936276566;18167.818321816743;18308.450746477494;18554.165062572218;1710.4270069526724;1746.3014794082342;1768.1071059115066;1805.2147315917487;1830.8535317174594;8979.910200897973;9175.678851240242;9290.581923813445;11097;12852.35738213095;1558.8908776385545;1647.1762340235211;1738.7913450385909;1740.5822602575417;1780.8219178082218;53860;55735;56467.99999999959;56479;56672;9596.520173991272;9779.902200978042;9808.166305863939;9839.901600983898;9848.162906152915;12510.31193284378;12536.185147965352;12539.686507837194;12552;12555.937220314023;6601.669916504252;6756.831079223059;7014.579125252501;7034.753783617549;7101.431885449255;6755;6820.488463365168;6838.179418469816;6869.862602748017;6936.063631409796;4166.395872598457;4210.852620158341;4231.492220933446;4250.06498570314;4272.893177670583;1579.9605009874615;1620.5705488045678;1632.6816270827076;1647.8681705463534;1712.092590926786;385.9749116307487;388.3611459149683;847.8812966184739;890.973270801877;946.7964387656549;9454.385464944757;9525.952370238105;9656.517174141265;10017.899821001696;10097.242706796873;413.9399787030924;420.155487470181;426.1966193724789;438.3512401645519;440.44943820224717;5544.86137846549;5565.638233514808;5640.915386269209;5684.431556844283;8785.604647790864;454876;456626;465453;468701;470388;67474;69565.65217173983;69851;70085;70251;1053.4048262731533;1069.2568664777905;1077.272840832435;1078.5200585739271;1079.228351728518;13530.93234533821;14153.292335383396;14569.927150364181;14753.704925901637;14878.181700006604;33245.33509329848;33498.33003339968;33732;33803.492947605315;33858.49212261769;41251.1749765009;42409;42793.572064280204;42949.78525107355;45275;8770.210681038738;8815.206631403205;8860.911390886009;9026.90973090287;9051.95474022652;10406.531706073094;11540.596079137189;16024.599385015468;16272.837271627131;16682.332706691595;10862.565497380016;11983.28100313984;12913.806292905427;13352.465901363837;13505.054646175067;12736.872631273569;12820.358982051046;12949.611511654666;13171.143875648053;13396.598102056954;11101.222914395914;11201;12993.285369304778;13660.248686322348;14076.296185190495;8690.565471726515;8734.912650873664;8738;8801.867971980297;8834.469931804113;12586;12745.426455809697;12959;13232;13626.182429054288 18:40:08 INFO - 2015-11-23 18:40:08,128 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1177.8233265010242;1570.7329753941833;1603.6872809802087;1630.8369163083694;1635.542048226497;5741.339745929219;6254.343293954137;6400.51996100292;6401;6406.359364063591;6532.314107018766;6637.203535575725;6643.501737369705;6645.900311495331;6648.135742353499;1721.7331313646341;1752.0538908989195;1998.2706312196017;2022.5348169920926;2026.392082375289;2074;2078.8233000194928;2080.8855512946857;2082.927097551586;2084.3538503064024;1963.9018049097488;1982.0783335748874;1982.8909409982446;1993.7308463357479;2027.2093883385492;1977.54516461214;1990.9701354479694;2021.3329601231558;2021.7472815898086;2043.3257025181654;2057.4753437873246;2084.812366886972;2087.8538502304846;2088.9477763055893;2090.143041353038;6679.799606011828;6761.29006454325;6778.118844550177;6779.72881084761;6803.251642319341;4025.5571887092397;4108.4453598764085;4108.650764685005;4114.465119534441;4121.340585506335;2259.1189436119926;2636.736326367367;2767.5848622706553;2776.763975062122;2787.958180627292;818.2594751749676;831.7962099285713;839.8866153069318;904.3533873280636;944.0606596436521;8960;8967.910320896837;8976.012638609813;8980.730578082668;9009.684661036832;3835.6931445484292;3837.884863454101;3930.9213815723524;3956.6043395660204;3968.0675041365257;7858.489198202098;7870.842583148305;7876.409269304825;7883.881741773878;7886.44794864354;4140.979295103505;4143.97928010364;4144.52337981136;4147.398627199039;4147.440095587057;3779.3575092234387;3781.3760729479327;3783.5459744830246;3783.9243215135543;3787.2614840105916;2874;2980.5976193214074;3047.1772621392543;3084.398542284233;3281.0648965044848;1053.8840727519967;1079.0935614084208;1087.798757229915;1087.9401632910108;1093.4314156638663;833.0420016980399;836.6277006731946;836.9874451883227;890.7505898348472;1025.8512515685334;6413.711382987777;6472.385123413268;6486.578372405778;6489.1888513935755;6489.1888513935755;1000.8198524265556;1023.97440063999;1025.6512785652915;1034.5758239121924;1053.6470282455464;4988.90022199554;5073.315102461121;5085.898282034413;5093.23601459784;5096.184610462308;7822.256885595859;7928.484648497829;7977.960110199412;8031.638576264082;8114.350851931831;7860.606969651494;7890.210978902179;7898;7901.565413902291;7976.641051152712;6274.121622972787;6279.183706118175;6318;6341.619502829845;6369.936300636934;5970.731317090828;6123.755049797958;6130.172426722335;6131.478824299806;6152.200213972155;7126.893096603451;7214.74748383804;7228.7469938554;7282.96358518204;7283.126024877049;7307.488475806643;7463;7465.626718663936;7471.439642026979;7514.436417268617;6007.4893634039845;6041.18444010053;6048.395160483917;6072.90890636632;6073.180120683828;5522.171674248895;5587.804426845041;6340.207474065742;6375.840603984938;6472.288048314776;5970.522358211246;6008.909866351921;6026.306974697965;6051.33435322123;6214.067889816563;6033.87932241344;6042.305134909541;6092.299385570539;6100.969495152496;6122.357152499102;6003.279606447254;6030.909536357046;6043.75824967014;6064.363241859542;6204.472619827366;5627.634203776742;5654.462826031685;5657.12314591239;5663.971680141738;5668.51817595509;5710.114932185518;5750.568707347049;5772.480476756944;5772.769089236552;5776.335721392094 18:40:08 INFO - 2015-11-23 18:40:08,129 DEBUG : BROWSER_OUTPUT: |4;prototype.html;305.454763247603;313.1357453428538;317.2006543510353;319.8496706547922;320.6889317362158;5217.399999000116;5226.895462090756;5370.91943620846;5403.972980135099;5414.729263536822;5206.349206349207;5308.575313974882;5327.680339179652;5338.893222135555;5341.145416733323;4238.894027649302;4242.703010789246;4242.8090735916885;4243.787810609472;4246.957530424703;4016.5581786003518;4099.3441049432095;4120.505539335284;4215.978920105395;4239.152169566084;4195.412642230091;4199.538050814408;4201.285781417151;4207.663386929054;4224.197402493532;4191.7484950903045;4207.326827707552;4207.873763787076;4213.325867861127;4221.092465119983;3738.607446218135;3744.101415660249;3744.1762812181278;3752.3433399155037;3754.3242216401036;4805.1864243555665;4927.601246105919;5185.455527169668;5192.091384007784;5195.558377537914;3987.581303963071;4533.909321813545;4756.405449318835;4758.904821903578;4765.809367625291;5518.172274158868;5575.665460072409;5591.2731344925305;5592.664440133564;5595.63628364155;3719.0702324418894;3787.8484860605545;3798.525184351956;3824.8278827452555;3843.5195600549932;5859.326177489601;5925.40745925404;5925.73334199962;5936.5250779937505;5939.970300148515;4062.5734297898293;4064.695147863922;4066.9796651016554;4067.7762723049923;4069.2675318442966;4114.403411505375;4123.0516981094515;4123.814428350672;4126.051008268055;4127.071408932966;4553.908921821611;4681.063787242565;4707.152712511781;4708.128996135657;4719.5752382285755;5637.49262566371;5639.943600563942;5640.633358831745;5642.830715078554;5642.887142257132;1442.213993373614;1460.2990564529086;1460.9342579583945;1461.4300422835104;1463.6926245488353;982.6167794560128;985.6254623243265;988.8269552828226;1003.6336737090909;1009.5406590001678;4947.431045429749;4952.232403977389;4953.182724850431;4956.479569645207;4960.627952903546;5849.298084229919;5850.063989761703;5850.385709500526;5853.239078919798;5858.121281807763;4935.87660308488;4953.23224900141;4956.504349565014;4957.20684690455;4961.355023846877;3051.1456792098247;3125.2655625927887;3132.4674805283157;3133.2793457504445;3151.9842400788307;5550.084236101079;5565.053940830068;5567.777288908479;5578;5580.832575022756;6064.120702498113;6065.5450841187085;6067.362926892612;6070.3019152798;6073.635581865014;5573.860653483614;5574.693391863405;5575.107982722745;5577.163425486128;5580.888382232414;5681.8863622726485;5842.065269556851;5863.589548731547;5896.764129434775;5940.108983652487;5537.584681148849;5685.914711279252;5769.59612827098;5780.884382312414;5781.219535362672;5398.2712333836;5539.446055394428;5551.195076713773;5576.637518561281;5579.13523403873;4037.93943090848;4086.530049044398;4087.3051581231857;4087.6116768906904;4093.9385909211983;5845.473907348359;5896.823095306976;5899.115132730125;5905.940940590711;5907.586468947133;5466.945330546644;5615.859603509945;5662.433756624469;5672.404397538364;5672.461116193955;5647.1529270609735;5655.236543066798;5655.915161272502;5658.886822263614;5661.065924122474;5510.8071217507195;5521.199426083276;5545.279113715191;5549.278593782782;5550.500454959073;5516.448355164452;5656.943430565641;5659;5723.6851973141875;5734.082546792493;5569.10894256917;5572;5575.721213939206;5578.916316255179;5583.302087239095 18:40:08 INFO - 2015-11-23 18:40:08,130 DEBUG : BROWSER_OUTPUT: |5;yui.html;619.0126747837198;693.337862341464;702.8769965256081;723.3959643697513;768.5772824946282;10452.79094418112;10842.945785271073;10854.837177442345;10868.402237876913;10870.836937445945;12215.144939854214;12327.383630818467;12332.075094367914;12342.32117233554;12356.135070545066;602.1509671363378;754.5548126605302;770.8882212079245;771.6874665760377;771.7298945369104;602.8944934636443;610.5237914426732;611.7063809371505;730.262434940711;753.1338960195791;794.8608993426157;796.6693822063866;803.0443771911436;803.1566854802463;803.4135081390589;797.5453991225004;798.9161138080505;799;799.4443861516248;799.448380617375;463.47395705873737;468.9859304220879;469.7463369780315;574.9827505174851;588.3322429043067;11543.249688770287;11593.76812463746;11663.708407289801;11668.88331116695;11703.824442633368;10884;11073.889261107366;11117;11121;11511.079113670887;8893.377463577552;9149.45103293798;9330.860037099448;9421.38760980534;9451.480168590724;3195.5206718992104;3211.245357341023;3265.951010734841;3288.638249792521;3340.983295083509;38934.02664933371;39126.41310380347;39475;39490.210195795924;39547;8837.734867953972;9224.492652904155;9422.811543769087;9587.18508926735;9795.167410770022;16181.19094045293;16195.838041619669;16199.919000404923;16204.59488512773;16215.513534593982;6023.578349515579;6259.593126446766;6275.309715931244;6332.905006424908;6437.034444833313;3392.6098498672477;3452.4648679454726;3564.4475106358555;3614.8192590370377;3692.48305237267;2681.865906704657;2698.311930457721;2699.987504685743;2701.648785657852;2703.986480067587;461.35871139116654;462.51667007976744;475.728834564295;484.33162236113935;485.1921550618252;398.81654438958407;421.2417648233168;432.53502484828937;439.53628921487496;605.8364241654816;6547.985062315349;6777.559458635173;6888.138982627172;6964.965175174193;7181.928180718231;403.6972270796902;427.2395136656756;439.97140185887815;452.127394129327;483.9954866678561;3041.1788817019283;3162.9525557116663;3408.2331475418327;3482.094655389617;3531;47756.28365574519;48546.27180592294;48603;48702.75648621734;53487;45008.77495612501;46113.308300375524;47213;47325;47864.282035769495;42947.57052429436;43666;44116.77941610335;44416;44439.4452942994;6758.290379510081;7295.416366690758;7617.542947423172;7682.500637458547;7957.204279571996;30415;31218.687813121578;31308.530372044894;31344.843275783474;31594.842025790644;37744;40714.38928416017;41560.1687966245;42073.579264206965;42422;8937.374383793072;9072.520377050014;9144.679936202201;9184.954075229849;9216.493092879688;10367.118794902517;10563.841542377024;10590.311629744043;10594.467918195458;10684.946575267073;10119;10265.486725663837;10671.306365086244;10676.412797296223;10716.19628527848;9326.440413575207;9650.324477286522;9678.419294842332;9846.31075824714;9927.900720992986;9669.371490853073;9970.052844979715;10167.796644067224;10495.685129446128;10523.894761052292;7850.6074696266105;7870.9606451967375;8046.436749427484;8184;8215.260626543639;7608.429367797326;7795.337396321376;7880.527168369917;8027.438079334391;8133 18:40:08 INFO - 2015-11-23 18:40:08,130 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:40:08 INFO - 2015-11-23 18:40:08,130 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:40:08 INFO - 2015-11-23 18:40:08,130 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,987 18:40:08 INFO - 2015-11-23 18:40:08,131 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:40:08 INFO - 2015-11-23 18:40:08,131 DEBUG : BROWSER_OUTPUT: __startTimestamp1448332808119__endTimestamp 18:40:08 INFO - 2015-11-23 18:40:08,131 DEBUG : BROWSER_OUTPUT: 18:40:08 INFO - 2015-11-23 18:40:08,131 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:40:08 INFO - 2015-11-23 18:40:08,131 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:40:08 INFO - 2015-11-23 18:40:08,131 DEBUG : BROWSER_OUTPUT: 18:40:08 INFO - 2015-11-23 18:40:08,131 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4566.79 Median:4695.84 stddev:464.87 (9.9%) stddev-sans-first:440.16 18:40:08 INFO - 2015-11-23 18:40:08,131 DEBUG : BROWSER_OUTPUT: Values: 2607.7 2677.3 2683.6 2693.0 2694.1 4456.9 4605.1 4608.6 4672.1 4692.4 4598.9 4603.8 4645.1 4654.8 4715.4 4273.0 4320.3 4326.6 4341.9 4414.1 4375.6 4411.9 4426.6 4431.9 4451.8 4144.4 4200.6 4247.9 4256.9 4282.9 4286.7 4292.7 4333.4 4343.8 4385.3 4280.2 4284.6 4292.0 4293.2 4329.3 4394.7 4516.0 4528.1 4536.0 4598.6 4948.9 4956.5 4963.9 4972.8 4999.4 4963.9 4975.5 4984.0 4984.3 5021.6 4485.2 4607.1 4607.3 4623.6 4630.8 4935.4 5005.7 5012.7 5014.2 5049.7 4896.1 4911.7 4912.2 4915.4 4960.5 4788.7 4967.1 4973.5 4977.9 4986.7 4802.7 4830.5 4851.0 4854.8 4862.5 4761.0 4811.0 4834.7 4836.3 4864.6 4107.1 4161.5 4162.6 4189.7 4205.6 3522.2 3628.0 3635.7 3643.9 3671.6 4209.0 4220.0 4275.0 4282.8 4318.8 4962.0 4966.0 4971.1 4973.6 5015.1 4105.1 4195.9 4279.5 4291.2 4326.3 4279.0 4352.7 4355.9 4367.5 4368.8 4656.1 4673.1 4704.2 4720.2 4759.9 4937.7 4940.1 4956.6 4979.3 4991.6 4525.2 4695.8 4708.7 4717.2 4842.1 4917.0 4917.8 4920.6 4929.6 4972.3 5010.8 5029.6 5030.8 5031.2 5061.9 4616.2 4683.6 4719.3 4719.8 4784.2 4757.0 4777.8 4779.8 4783.7 4818.4 4685.5 4700.1 4707.5 4751.5 4752.5 4555.7 4705.2 4705.2 4765.7 4884.2 4672.9 4727.9 4731.8 4732.8 4778.7 18:40:08 INFO - 2015-11-23 18:40:08,131 DEBUG : BROWSER_OUTPUT: 18:40:08 INFO - 2015-11-23 18:40:08,131 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42868.02 Median:337837.50 stddev:71299.60 (21.1%) stddev-sans-first:71428.79 18:40:08 INFO - 2015-11-23 18:40:08,131 DEBUG : BROWSER_OUTPUT: Values: 540.8 549.9 565.6 569.7 574.7 28121.9 28611.0 36528.3 37446.8 37532.4 40418.0 40694.0 40757.6 40763.6 40771.6 6993.7 7816.9 7979.4 7988.6 8005.6 7078.6 7163.4 7169.9 7177.7 9729.5 9871.6 9984.5 9994.8 9996.4 10002.8 9954.6 10067.3 10067.7 10074.4 10076.3 7122.4 7305.9 10061.5 10453.7 10457.8 36910.1 37242.0 37259.3 37277.1 37372.4 2401.6 2410.2 2439.7 2525.4 2543.9 27481.6 27982.2 28114.2 28146.7 28513.0 3396.8 3539.0 3539.5 3549.6 3666.1 222304.0 223620.0 224050.0 224580.0 224752.0 44605.0 45857.0 56215.4 56605.7 56619.4 58839.4 59809.0 60015.4 60082.1 60093.7 14006.6 14191.7 14201.1 14224.2 14225.5 10761.7 10837.5 10848.9 10850.7 10868.6 18726.0 19007.8 19057.2 19161.3 19166.5 7365.3 7852.4 7860.7 7906.2 7912.4 844.4 882.3 908.0 985.5 1032.1 25433.2 25738.6 25760.9 26018.0 26173.6 948.4 951.3 981.0 1051.8 1114.2 14860.6 15290.8 15300.3 15394.5 15935.4 332530.0 336143.0 337408.0 337582.0 338093.0 48960.3 49416.3 49446.5 49550.5 49570.5 1204.0 1217.8 1222.5 1222.5 1233.6 26664.1 26805.7 27378.2 27593.6 27742.0 38948.2 39435.2 39480.0 39488.0 39499.6 242427.0 243650.0 243706.0 244145.0 244326.0 23755.5 24045.3 27929.3 28653.7 29189.9 33316.2 33656.3 44321.0 44703.0 45401.0 33945.2 34252.8 34299.5 34402.5 34911.7 33952.3 34484.1 34516.3 34535.1 36880.0 30712.5 32519.3 34603.8 34868.7 37506.0 29259.0 30986.2 31244.0 31252.7 31298.8 23504.0 23656.8 23682.4 23888.3 23985.3 18:40:08 INFO - 2015-11-23 18:40:08,131 DEBUG : BROWSER_OUTPUT: 18:40:08 INFO - 2015-11-23 18:40:08,131 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25140.17 Median:23329.53 stddev:75746.08 (324.7%) stddev-sans-first:75935.64 18:40:08 INFO - 2015-11-23 18:40:08,133 DEBUG : BROWSER_OUTPUT: Values: 319.9 332.6 333.2 336.3 339.1 12429.4 12840.2 14971.7 15482.8 15820.3 9378.5 9678.7 9682.2 12351.6 13134.9 4616.5 4735.6 4739.1 4746.3 4748.5 3324.2 4650.5 4789.8 5299.4 5308.9 5238.7 5243.9 5260.3 5260.9 5286.2 5228.4 5348.2 5579.9 5588.1 5588.2 4922.9 4924.0 4926.3 4934.4 4936.1 17915.5 18042.5 18167.8 18308.5 18554.2 1710.4 1746.3 1768.1 1805.2 1830.9 8979.9 9175.7 9290.6 11097.0 12852.4 1558.9 1647.2 1738.8 1740.6 1780.8 53860.0 55735.0 56468.0 56479.0 56672.0 9596.5 9779.9 9808.2 9839.9 9848.2 12510.3 12536.2 12539.7 12552.0 12555.9 6601.7 6756.8 7014.6 7034.8 7101.4 6755.0 6820.5 6838.2 6869.9 6936.1 4166.4 4210.9 4231.5 4250.1 4272.9 1580.0 1620.6 1632.7 1647.9 1712.1 386.0 388.4 847.9 891.0 946.8 9454.4 9526.0 9656.5 10017.9 10097.2 413.9 420.2 426.2 438.4 440.4 5544.9 5565.6 5640.9 5684.4 8785.6 454876.0 456626.0 465453.0 468701.0 470388.0 67474.0 69565.7 69851.0 70085.0 70251.0 1053.4 1069.3 1077.3 1078.5 1079.2 13530.9 14153.3 14569.9 14753.7 14878.2 33245.3 33498.3 33732.0 33803.5 33858.5 41251.2 42409.0 42793.6 42949.8 45275.0 8770.2 8815.2 8860.9 9026.9 9052.0 10406.5 11540.6 16024.6 16272.8 16682.3 10862.6 11983.3 12913.8 13352.5 13505.1 12736.9 12820.4 12949.6 13171.1 13396.6 11101.2 11201.0 12993.3 13660.2 14076.3 8690.6 8734.9 8738.0 8801.9 8834.5 12586.0 12745.4 12959.0 13232.0 13626.2 18:40:08 INFO - 2015-11-23 18:40:08,133 DEBUG : BROWSER_OUTPUT: 18:40:08 INFO - 2015-11-23 18:40:08,133 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4716.27 Median:5987.01 stddev:2388.71 (39.9%) stddev-sans-first:2380.60 18:40:08 INFO - 2015-11-23 18:40:08,133 DEBUG : BROWSER_OUTPUT: Values: 1177.8 1570.7 1603.7 1630.8 1635.5 5741.3 6254.3 6400.5 6401.0 6406.4 6532.3 6637.2 6643.5 6645.9 6648.1 1721.7 1752.1 1998.3 2022.5 2026.4 2074.0 2078.8 2080.9 2082.9 2084.4 1963.9 1982.1 1982.9 1993.7 2027.2 1977.5 1991.0 2021.3 2021.7 2043.3 2057.5 2084.8 2087.9 2088.9 2090.1 6679.8 6761.3 6778.1 6779.7 6803.3 4025.6 4108.4 4108.7 4114.5 4121.3 2259.1 2636.7 2767.6 2776.8 2788.0 818.3 831.8 839.9 904.4 944.1 8960.0 8967.9 8976.0 8980.7 9009.7 3835.7 3837.9 3930.9 3956.6 3968.1 7858.5 7870.8 7876.4 7883.9 7886.4 4141.0 4144.0 4144.5 4147.4 4147.4 3779.4 3781.4 3783.5 3783.9 3787.3 2874.0 2980.6 3047.2 3084.4 3281.1 1053.9 1079.1 1087.8 1087.9 1093.4 833.0 836.6 837.0 890.8 1025.9 6413.7 6472.4 6486.6 6489.2 6489.2 1000.8 1024.0 1025.7 1034.6 1053.6 4988.9 5073.3 5085.9 5093.2 5096.2 7822.3 7928.5 7978.0 8031.6 8114.4 7860.6 7890.2 7898.0 7901.6 7976.6 6274.1 6279.2 6318.0 6341.6 6369.9 5970.7 6123.8 6130.2 6131.5 6152.2 7126.9 7214.7 7228.7 7283.0 7283.1 7307.5 7463.0 7465.6 7471.4 7514.4 6007.5 6041.2 6048.4 6072.9 6073.2 5522.2 5587.8 6340.2 6375.8 6472.3 5970.5 6008.9 6026.3 6051.3 6214.1 6033.9 6042.3 6092.3 6101.0 6122.4 6003.3 6030.9 6043.8 6064.4 6204.5 5627.6 5654.5 5657.1 5664.0 5668.5 5710.1 5750.6 5772.5 5772.8 5776.3 18:40:08 INFO - 2015-11-23 18:40:08,133 DEBUG : BROWSER_OUTPUT: 18:40:08 INFO - 2015-11-23 18:40:08,133 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4681.69 Median:5318.13 stddev:1372.77 (25.8%) stddev-sans-first:1336.75 18:40:08 INFO - 2015-11-23 18:40:08,133 DEBUG : BROWSER_OUTPUT: Values: 305.5 313.1 317.2 319.8 320.7 5217.4 5226.9 5370.9 5404.0 5414.7 5206.3 5308.6 5327.7 5338.9 5341.1 4238.9 4242.7 4242.8 4243.8 4247.0 4016.6 4099.3 4120.5 4216.0 4239.2 4195.4 4199.5 4201.3 4207.7 4224.2 4191.7 4207.3 4207.9 4213.3 4221.1 3738.6 3744.1 3744.2 3752.3 3754.3 4805.2 4927.6 5185.5 5192.1 5195.6 3987.6 4533.9 4756.4 4758.9 4765.8 5518.2 5575.7 5591.3 5592.7 5595.6 3719.1 3787.8 3798.5 3824.8 3843.5 5859.3 5925.4 5925.7 5936.5 5940.0 4062.6 4064.7 4067.0 4067.8 4069.3 4114.4 4123.1 4123.8 4126.1 4127.1 4553.9 4681.1 4707.2 4708.1 4719.6 5637.5 5639.9 5640.6 5642.8 5642.9 1442.2 1460.3 1460.9 1461.4 1463.7 982.6 985.6 988.8 1003.6 1009.5 4947.4 4952.2 4953.2 4956.5 4960.6 5849.3 5850.1 5850.4 5853.2 5858.1 4935.9 4953.2 4956.5 4957.2 4961.4 3051.1 3125.3 3132.5 3133.3 3152.0 5550.1 5565.1 5567.8 5578.0 5580.8 6064.1 6065.5 6067.4 6070.3 6073.6 5573.9 5574.7 5575.1 5577.2 5580.9 5681.9 5842.1 5863.6 5896.8 5940.1 5537.6 5685.9 5769.6 5780.9 5781.2 5398.3 5539.4 5551.2 5576.6 5579.1 4037.9 4086.5 4087.3 4087.6 4093.9 5845.5 5896.8 5899.1 5905.9 5907.6 5466.9 5615.9 5662.4 5672.4 5672.5 5647.2 5655.2 5655.9 5658.9 5661.1 5510.8 5521.2 5545.3 5549.3 5550.5 5516.4 5656.9 5659.0 5723.7 5734.1 5569.1 5572.0 5575.7 5578.9 5583.3 18:40:08 INFO - 2015-11-23 18:40:08,133 DEBUG : BROWSER_OUTPUT: 18:40:08 INFO - 2015-11-23 18:40:08,135 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12140.86 Median:466.23 stddev:14206.14 (3047.0%) stddev-sans-first:14219.64 18:40:08 INFO - 2015-11-23 18:40:08,135 DEBUG : BROWSER_OUTPUT: Values: 619.0 693.3 702.9 723.4 768.6 10452.8 10842.9 10854.8 10868.4 10870.8 12215.1 12327.4 12332.1 12342.3 12356.1 602.2 754.6 770.9 771.7 771.7 602.9 610.5 611.7 730.3 753.1 794.9 796.7 803.0 803.2 803.4 797.5 798.9 799.0 799.4 799.4 463.5 469.0 469.7 575.0 588.3 11543.2 11593.8 11663.7 11668.9 11703.8 10884.0 11073.9 11117.0 11121.0 11511.1 8893.4 9149.5 9330.9 9421.4 9451.5 3195.5 3211.2 3266.0 3288.6 3341.0 38934.0 39126.4 39475.0 39490.2 39547.0 8837.7 9224.5 9422.8 9587.2 9795.2 16181.2 16195.8 16199.9 16204.6 16215.5 6023.6 6259.6 6275.3 6332.9 6437.0 3392.6 3452.5 3564.4 3614.8 3692.5 2681.9 2698.3 2700.0 2701.6 2704.0 461.4 462.5 475.7 484.3 485.2 398.8 421.2 432.5 439.5 605.8 6548.0 6777.6 6888.1 6965.0 7181.9 403.7 427.2 440.0 452.1 484.0 3041.2 3163.0 3408.2 3482.1 3531.0 47756.3 48546.3 48603.0 48702.8 53487.0 45008.8 46113.3 47213.0 47325.0 47864.3 42947.6 43666.0 44116.8 44416.0 44439.4 6758.3 7295.4 7617.5 7682.5 7957.2 30415.0 31218.7 31308.5 31344.8 31594.8 37744.0 40714.4 41560.2 42073.6 42422.0 8937.4 9072.5 9144.7 9185.0 9216.5 10367.1 10563.8 10590.3 10594.5 10684.9 10119.0 10265.5 10671.3 10676.4 10716.2 9326.4 9650.3 9678.4 9846.3 9927.9 9669.4 9970.1 10167.8 10495.7 10523.9 7850.6 7871.0 8046.4 8184.0 8215.3 7608.4 7795.3 7880.5 8027.4 8133.0 18:40:08 INFO - 2015-11-23 18:40:08,135 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:40:08 INFO - 2015-11-23 18:40:08,135 DEBUG : BROWSER_OUTPUT: 18:40:08 INFO - 2015-11-23 18:40:08,945 INFO : Browser exited with error code: 0 18:40:08 INFO - 2015-11-23 18:40:08,967 INFO : Completed test dromaeo_css (00:18:39) 18:40:08 INFO - 2015-11-23 18:40:08,967 INFO : Starting test kraken 18:40:08 INFO - 2015-11-23 18:40:08,967 DEBUG : operating with platform_type : linux_ 18:40:08 INFO - 2015-11-23 18:40:08,967 INFO : Initialising browser for kraken test... 18:40:08 INFO - 2015-11-23 18:40:08,973 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwWdk3s/profile http://localhost:49550/getInfo.html 18:40:12 INFO - 2015-11-23 18:40:12,522 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:40:12 INFO - 2015-11-23 18:40:12,522 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:40:12 INFO - 2015-11-23 18:40:12,522 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:40:12 INFO - 2015-11-23 18:40:12,522 DEBUG : BROWSER_OUTPUT: __metrics 18:40:12 INFO - 2015-11-23 18:40:12,665 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:40:13 INFO - 2015-11-23 18:40:13,793 INFO : Browser initialized. 18:40:13 INFO - 2015-11-23 18:40:13,793 INFO : Running cycle 1/1 for kraken test... 18:40:13 INFO - 2015-11-23 18:40:13,794 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwWdk3s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:40:25 INFO - 2015-11-23 18:40:25,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 140398592 18:40:25 INFO - 2015-11-23 18:40:25,668 DEBUG : BROWSER_OUTPUT: 18:40:28 INFO - 2015-11-23 18:40:28,295 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49550/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49550/tests/kraken/driver.html?testName=audio-beat-detection) 18:40:28 INFO - 2015-11-23 18:40:28,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 180269056 18:40:28 INFO - 2015-11-23 18:40:28,881 DEBUG : BROWSER_OUTPUT: 18:40:31 INFO - 2015-11-23 18:40:31,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49550/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49550/tests/kraken/driver.html?testName=audio-dft) 18:40:32 INFO - 2015-11-23 18:40:32,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 167374848 18:40:32 INFO - 2015-11-23 18:40:32,164 DEBUG : BROWSER_OUTPUT: 18:40:35 INFO - 2015-11-23 18:40:35,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49550/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49550/tests/kraken/driver.html?testName=audio-fft) 18:40:35 INFO - 2015-11-23 18:40:35,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 152477696 18:40:35 INFO - 2015-11-23 18:40:35,700 DEBUG : BROWSER_OUTPUT: 18:40:37 INFO - 2015-11-23 18:40:37,720 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49550/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49550/tests/kraken/driver.html?testName=audio-oscillator) 18:40:38 INFO - 2015-11-23 18:40:38,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 154730496 18:40:38 INFO - 2015-11-23 18:40:38,294 DEBUG : BROWSER_OUTPUT: 18:40:40 INFO - 2015-11-23 18:40:40,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49550/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49550/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:40:41 INFO - 2015-11-23 18:40:41,084 DEBUG : BROWSER_OUTPUT: RSS: Main: 155525120 18:40:41 INFO - 2015-11-23 18:40:41,084 DEBUG : BROWSER_OUTPUT: 18:40:44 INFO - 2015-11-23 18:40:44,124 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49550/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49550/tests/kraken/driver.html?testName=imaging-darkroom) 18:40:44 INFO - 2015-11-23 18:40:44,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 155062272 18:40:44 INFO - 2015-11-23 18:40:44,697 DEBUG : BROWSER_OUTPUT: 18:40:48 INFO - 2015-11-23 18:40:48,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49550/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49550/tests/kraken/driver.html?testName=imaging-desaturate) 18:40:48 INFO - 2015-11-23 18:40:48,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 157212672 18:40:48 INFO - 2015-11-23 18:40:48,685 DEBUG : BROWSER_OUTPUT: 18:40:51 INFO - 2015-11-23 18:40:51,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49550/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49550/tests/kraken/driver.html?testName=json-parse-financial) 18:40:52 INFO - 2015-11-23 18:40:52,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 155746304 18:40:52 INFO - 2015-11-23 18:40:52,069 DEBUG : BROWSER_OUTPUT: 18:40:53 INFO - 2015-11-23 18:40:53,848 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49550/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49550/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:40:54 INFO - 2015-11-23 18:40:54,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 166248448 18:40:54 INFO - 2015-11-23 18:40:54,421 DEBUG : BROWSER_OUTPUT: 18:40:56 INFO - 2015-11-23 18:40:56,316 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49550/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49550/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:40:56 INFO - 2015-11-23 18:40:56,918 DEBUG : BROWSER_OUTPUT: RSS: Main: 166051840 18:40:56 INFO - 2015-11-23 18:40:56,918 DEBUG : BROWSER_OUTPUT: 18:40:59 INFO - 2015-11-23 18:40:59,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49550/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49550/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:40:59 INFO - 2015-11-23 18:40:59,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 176369664 18:40:59 INFO - 2015-11-23 18:40:59,655 DEBUG : BROWSER_OUTPUT: 18:41:02 INFO - 2015-11-23 18:41:02,202 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49550/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49550/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:41:02 INFO - 2015-11-23 18:41:02,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 183259136 18:41:02 INFO - 2015-11-23 18:41:02,788 DEBUG : BROWSER_OUTPUT: 18:41:05 INFO - 2015-11-23 18:41:05,427 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49550/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49550/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:41:06 INFO - 2015-11-23 18:41:06,000 DEBUG : BROWSER_OUTPUT: RSS: Main: 182128640 18:41:06 INFO - 2015-11-23 18:41:06,001 DEBUG : BROWSER_OUTPUT: 18:41:07 INFO - 2015-11-23 18:41:07,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49550/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49550/tests/kraken/driver.html?testName=ai-astar) 18:41:08 INFO - 2015-11-23 18:41:08,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 241164288 18:41:08 INFO - 2015-11-23 18:41:08,005 DEBUG : BROWSER_OUTPUT: 18:41:08 INFO - 2015-11-23 18:41:08,006 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:41:08 INFO - 2015-11-23 18:41:08,006 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:41:08 INFO - 2015-11-23 18:41:08,006 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:41:08 INFO - 2015-11-23 18:41:08,007 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:41:08 INFO - 2015-11-23 18:41:08,007 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;116;109;112;112;114;103;114;112;106 18:41:08 INFO - 2015-11-23 18:41:08,007 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;130;160;172;132;154;151;134;168;129 18:41:08 INFO - 2015-11-23 18:41:08,007 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;162;162;159;160;159;161;160;161 18:41:08 INFO - 2015-11-23 18:41:08,007 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;86;90;71;71;72;102;89;71 18:41:08 INFO - 2015-11-23 18:41:08,008 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;131;94;94;93;135;94;94;127 18:41:08 INFO - 2015-11-23 18:41:08,008 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;110;109;110;109;109 18:41:08 INFO - 2015-11-23 18:41:08,008 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;147;146;146;146;147;146;146;148 18:41:08 INFO - 2015-11-23 18:41:08,008 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;95;95;95;95;95;95 18:41:08 INFO - 2015-11-23 18:41:08,008 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;70;70;70;70;71;70;79;68;69 18:41:08 INFO - 2015-11-23 18:41:08,008 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;67;68;68;69;69;69;69;69 18:41:08 INFO - 2015-11-23 18:41:08,009 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;83;84;83;84;83;89;83;85;92 18:41:08 INFO - 2015-11-23 18:41:08,009 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;120;128;119;127;122;123;130;129;129 18:41:08 INFO - 2015-11-23 18:41:08,009 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;151;148;153;148;147;135;136;152;155;136 18:41:08 INFO - 2015-11-23 18:41:08,009 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;69;69;71;69;69;67;69;68 18:41:08 INFO - 2015-11-23 18:41:08,009 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:41:08 INFO - 2015-11-23 18:41:08,009 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:41:08 INFO - 2015-11-23 18:41:08,009 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,990 18:41:08 INFO - 2015-11-23 18:41:08,009 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:41:08 INFO - 2015-11-23 18:41:08,009 DEBUG : BROWSER_OUTPUT: __startTimestamp1448332868005__endTimestamp 18:41:08 INFO - 2015-11-23 18:41:08,009 DEBUG : BROWSER_OUTPUT: 18:41:08 INFO - 2015-11-23 18:41:08,013 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:41:08 INFO - 2015-11-23 18:41:08,013 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:41:08 INFO - 2015-11-23 18:41:08,013 DEBUG : BROWSER_OUTPUT: 18:41:08 INFO - 2015-11-23 18:41:08,013 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:3.94 (3.5%) stddev-sans-first:4.17 18:41:08 INFO - 2015-11-23 18:41:08,013 DEBUG : BROWSER_OUTPUT: Values: 112.0 116.0 109.0 112.0 112.0 114.0 103.0 114.0 112.0 106.0 18:41:08 INFO - 2015-11-23 18:41:08,013 DEBUG : BROWSER_OUTPUT: 18:41:08 INFO - 2015-11-23 18:41:08,013 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.30 Median:153.50 stddev:16.08 (10.5%) stddev-sans-first:16.96 18:41:08 INFO - 2015-11-23 18:41:08,013 DEBUG : BROWSER_OUTPUT: Values: 153.0 130.0 160.0 172.0 132.0 154.0 151.0 134.0 168.0 129.0 18:41:08 INFO - 2015-11-23 18:41:08,013 DEBUG : BROWSER_OUTPUT: 18:41:08 INFO - 2015-11-23 18:41:08,013 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 18:41:08 INFO - 2015-11-23 18:41:08,013 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 162.0 162.0 159.0 160.0 159.0 161.0 160.0 161.0 18:41:08 INFO - 2015-11-23 18:41:08,013 DEBUG : BROWSER_OUTPUT: 18:41:08 INFO - 2015-11-23 18:41:08,013 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.50 Median:72.00 stddev:11.31 (15.7%) stddev-sans-first:11.57 18:41:08 INFO - 2015-11-23 18:41:08,014 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 86.0 90.0 71.0 71.0 72.0 102.0 89.0 71.0 18:41:08 INFO - 2015-11-23 18:41:08,014 DEBUG : BROWSER_OUTPUT: 18:41:08 INFO - 2015-11-23 18:41:08,014 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.00 Median:94.00 stddev:18.04 (19.2%) stddev-sans-first:18.69 18:41:08 INFO - 2015-11-23 18:41:08,014 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 131.0 94.0 94.0 93.0 135.0 94.0 94.0 127.0 18:41:08 INFO - 2015-11-23 18:41:08,014 DEBUG : BROWSER_OUTPUT: 18:41:08 INFO - 2015-11-23 18:41:08,014 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:41:08 INFO - 2015-11-23 18:41:08,014 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 110.0 109.0 110.0 109.0 109.0 18:41:08 INFO - 2015-11-23 18:41:08,014 DEBUG : BROWSER_OUTPUT: 18:41:08 INFO - 2015-11-23 18:41:08,014 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 18:41:08 INFO - 2015-11-23 18:41:08,014 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 148.0 18:41:08 INFO - 2015-11-23 18:41:08,014 DEBUG : BROWSER_OUTPUT: 18:41:08 INFO - 2015-11-23 18:41:08,014 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:41:08 INFO - 2015-11-23 18:41:08,014 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 18:41:08 INFO - 2015-11-23 18:41:08,014 DEBUG : BROWSER_OUTPUT: 18:41:08 INFO - 2015-11-23 18:41:08,014 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.70 Median:70.00 stddev:3.02 (4.3%) stddev-sans-first:3.19 18:41:08 INFO - 2015-11-23 18:41:08,014 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 70.0 70.0 71.0 70.0 79.0 68.0 69.0 18:41:08 INFO - 2015-11-23 18:41:08,015 DEBUG : BROWSER_OUTPUT: 18:41:08 INFO - 2015-11-23 18:41:08,015 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.71 (1.0%) stddev-sans-first:0.73 18:41:08 INFO - 2015-11-23 18:41:08,015 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 67.0 68.0 68.0 69.0 69.0 69.0 69.0 69.0 18:41:08 INFO - 2015-11-23 18:41:08,015 DEBUG : BROWSER_OUTPUT: 18:41:08 INFO - 2015-11-23 18:41:08,015 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:84.50 stddev:3.41 (4.0%) stddev-sans-first:3.22 18:41:08 INFO - 2015-11-23 18:41:08,015 DEBUG : BROWSER_OUTPUT: Values: 90.0 83.0 84.0 83.0 84.0 83.0 89.0 83.0 85.0 92.0 18:41:08 INFO - 2015-11-23 18:41:08,015 DEBUG : BROWSER_OUTPUT: 18:41:08 INFO - 2015-11-23 18:41:08,015 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:127.50 stddev:3.99 (3.1%) stddev-sans-first:4.24 18:41:08 INFO - 2015-11-23 18:41:08,015 DEBUG : BROWSER_OUTPUT: Values: 125.0 120.0 128.0 119.0 127.0 122.0 123.0 130.0 129.0 129.0 18:41:08 INFO - 2015-11-23 18:41:08,015 DEBUG : BROWSER_OUTPUT: 18:41:08 INFO - 2015-11-23 18:41:08,015 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.10 Median:149.50 stddev:7.61 (5.1%) stddev-sans-first:7.86 18:41:08 INFO - 2015-11-23 18:41:08,015 DEBUG : BROWSER_OUTPUT: Values: 151.0 148.0 153.0 148.0 147.0 135.0 136.0 152.0 155.0 136.0 18:41:08 INFO - 2015-11-23 18:41:08,016 DEBUG : BROWSER_OUTPUT: 18:41:08 INFO - 2015-11-23 18:41:08,016 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:0.99 (1.4%) stddev-sans-first:1.05 18:41:08 INFO - 2015-11-23 18:41:08,016 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 71.0 69.0 69.0 67.0 69.0 68.0 18:41:08 INFO - 2015-11-23 18:41:08,016 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:41:08 INFO - 2015-11-23 18:41:08,016 DEBUG : BROWSER_OUTPUT: 18:41:08 INFO - 2015-11-23 18:41:08,905 INFO : Browser exited with error code: 0 18:41:08 INFO - 2015-11-23 18:41:08,957 INFO : Completed test kraken (00:00:59) 18:41:08 INFO - 2015-11-23 18:41:08,957 INFO : Starting test v8_7 18:41:08 INFO - 2015-11-23 18:41:08,957 DEBUG : operating with platform_type : linux_ 18:41:08 INFO - 2015-11-23 18:41:08,957 INFO : Initialising browser for v8_7 test... 18:41:08 INFO - 2015-11-23 18:41:08,963 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8V15Qh/profile http://localhost:49550/getInfo.html 18:41:12 INFO - 2015-11-23 18:41:12,617 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:41:12 INFO - 2015-11-23 18:41:12,618 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:41:12 INFO - 2015-11-23 18:41:12,618 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:41:12 INFO - 2015-11-23 18:41:12,618 DEBUG : BROWSER_OUTPUT: __metrics 18:41:12 INFO - 2015-11-23 18:41:12,747 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:41:13 INFO - 2015-11-23 18:41:13,372 DEBUG : BROWSER_OUTPUT: console.error: 18:41:13 INFO - 2015-11-23 18:41:13,374 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 18:41:13 INFO - 2015-11-23 18:41:13,374 DEBUG : BROWSER_OUTPUT: Stack: 18:41:13 INFO - 2015-11-23 18:41:13,374 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 18:41:13 INFO - 2015-11-23 18:41:13,374 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 18:41:13 INFO - 2015-11-23 18:41:13,374 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 18:41:13 INFO - 2015-11-23 18:41:13,374 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 18:41:13 INFO - 2015-11-23 18:41:13,374 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 18:41:13 INFO - 2015-11-23 18:41:13,374 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 18:41:13 INFO - 2015-11-23 18:41:13,374 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 18:41:13 INFO - 2015-11-23 18:41:13,374 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 18:41:13 INFO - 2015-11-23 18:41:13,374 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 18:41:13 INFO - 2015-11-23 18:41:13,374 DEBUG : BROWSER_OUTPUT: 18:41:13 INFO - 2015-11-23 18:41:13,968 INFO : Browser initialized. 18:41:13 INFO - 2015-11-23 18:41:13,968 INFO : Running cycle 1/1 for v8_7 test... 18:41:13 INFO - 2015-11-23 18:41:13,969 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8V15Qh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:41:25 INFO - 2015-11-23 18:41:25,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 139792384 18:41:25 INFO - 2015-11-23 18:41:25,912 DEBUG : BROWSER_OUTPUT: 18:41:47 INFO - 2015-11-23 18:41:47,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49550/tests/v8_7/run.html (next: http://localhost:49550/tests/v8_7/run.html) 18:41:47 INFO - 2015-11-23 18:41:47,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 442687488 18:41:47 INFO - 2015-11-23 18:41:47,607 DEBUG : BROWSER_OUTPUT: 18:41:47 INFO - 2015-11-23 18:41:47,608 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:41:47 INFO - 2015-11-23 18:41:47,608 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:41:47 INFO - 2015-11-23 18:41:47,608 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:41:47 INFO - 2015-11-23 18:41:47,608 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:41:47 INFO - 2015-11-23 18:41:47,608 DEBUG : BROWSER_OUTPUT: |0;Richards;200 18:41:47 INFO - 2015-11-23 18:41:47,609 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.79133103183736 18:41:47 INFO - 2015-11-23 18:41:47,609 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4857462269424 18:41:47 INFO - 2015-11-23 18:41:47,609 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5000 18:41:47 INFO - 2015-11-23 18:41:47,609 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1980.1980198019803 18:41:47 INFO - 2015-11-23 18:41:47,609 DEBUG : BROWSER_OUTPUT: |5;Earley;796.8127490039841 18:41:47 INFO - 2015-11-23 18:41:47,609 DEBUG : BROWSER_OUTPUT: |6;Boyer;11952.380952380952 18:41:47 INFO - 2015-11-23 18:41:47,609 DEBUG : BROWSER_OUTPUT: |7;RegExp;26973.684210526317 18:41:47 INFO - 2015-11-23 18:41:47,609 DEBUG : BROWSER_OUTPUT: |8;Splay;609.2995169082126 18:41:47 INFO - 2015-11-23 18:41:47,609 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 18:41:47 INFO - 2015-11-23 18:41:47,609 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:41:47 INFO - 2015-11-23 18:41:47,609 DEBUG : BROWSER_OUTPUT: __startTimestamp1448332907607__endTimestamp 18:41:47 INFO - 2015-11-23 18:41:47,610 DEBUG : BROWSER_OUTPUT: 18:41:47 INFO - 2015-11-23 18:41:47,610 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:41:47 INFO - 2015-11-23 18:41:47,610 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:41:47 INFO - 2015-11-23 18:41:47,610 DEBUG : BROWSER_OUTPUT: 18:41:47 INFO - 2015-11-23 18:41:47,610 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:200.00 Median:200.00 stddev:0.00 (0.0%) 18:41:47 INFO - 2015-11-23 18:41:47,610 DEBUG : BROWSER_OUTPUT: Values: 200.0 18:41:47 INFO - 2015-11-23 18:41:47,610 DEBUG : BROWSER_OUTPUT: 18:41:47 INFO - 2015-11-23 18:41:47,610 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.79 Median:191.79 stddev:0.00 (0.0%) 18:41:47 INFO - 2015-11-23 18:41:47,610 DEBUG : BROWSER_OUTPUT: Values: 191.8 18:41:47 INFO - 2015-11-23 18:41:47,610 DEBUG : BROWSER_OUTPUT: 18:41:47 INFO - 2015-11-23 18:41:47,610 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.49 Median:279.49 stddev:0.00 (0.0%) 18:41:47 INFO - 2015-11-23 18:41:47,610 DEBUG : BROWSER_OUTPUT: Values: 279.5 18:41:47 INFO - 2015-11-23 18:41:47,611 DEBUG : BROWSER_OUTPUT: 18:41:47 INFO - 2015-11-23 18:41:47,611 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5000.00 Median:5000.00 stddev:0.00 (0.0%) 18:41:47 INFO - 2015-11-23 18:41:47,611 DEBUG : BROWSER_OUTPUT: Values: 5000.0 18:41:47 INFO - 2015-11-23 18:41:47,611 DEBUG : BROWSER_OUTPUT: 18:41:47 INFO - 2015-11-23 18:41:47,611 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1980.20 Median:1980.20 stddev:0.00 (0.0%) 18:41:47 INFO - 2015-11-23 18:41:47,611 DEBUG : BROWSER_OUTPUT: Values: 1980.2 18:41:47 INFO - 2015-11-23 18:41:47,611 DEBUG : BROWSER_OUTPUT: 18:41:47 INFO - 2015-11-23 18:41:47,611 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:796.81 Median:796.81 stddev:0.00 (0.0%) 18:41:47 INFO - 2015-11-23 18:41:47,611 DEBUG : BROWSER_OUTPUT: Values: 796.8 18:41:47 INFO - 2015-11-23 18:41:47,611 DEBUG : BROWSER_OUTPUT: 18:41:47 INFO - 2015-11-23 18:41:47,611 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11952.38 Median:11952.38 stddev:0.00 (0.0%) 18:41:47 INFO - 2015-11-23 18:41:47,613 DEBUG : BROWSER_OUTPUT: Values: 11952.4 18:41:47 INFO - 2015-11-23 18:41:47,613 DEBUG : BROWSER_OUTPUT: 18:41:47 INFO - 2015-11-23 18:41:47,613 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26973.68 Median:26973.68 stddev:0.00 (0.0%) 18:41:47 INFO - 2015-11-23 18:41:47,613 DEBUG : BROWSER_OUTPUT: Values: 26973.7 18:41:47 INFO - 2015-11-23 18:41:47,613 DEBUG : BROWSER_OUTPUT: 18:41:47 INFO - 2015-11-23 18:41:47,613 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:609.30 Median:609.30 stddev:0.00 (0.0%) 18:41:47 INFO - 2015-11-23 18:41:47,613 DEBUG : BROWSER_OUTPUT: Values: 609.3 18:41:47 INFO - 2015-11-23 18:41:47,613 DEBUG : BROWSER_OUTPUT: 18:41:47 INFO - 2015-11-23 18:41:47,613 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 18:41:47 INFO - 2015-11-23 18:41:47,614 DEBUG : BROWSER_OUTPUT: Values: 4835.7 18:41:47 INFO - 2015-11-23 18:41:47,614 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:41:47 INFO - 2015-11-23 18:41:47,614 DEBUG : BROWSER_OUTPUT: 18:41:48 INFO - 2015-11-23 18:41:48,513 INFO : Browser exited with error code: 0 18:41:48 INFO - 2015-11-23 18:41:48,526 INFO : Completed test v8_7 (00:00:39) 18:41:48 INFO - 2015-11-23 18:41:48,603 INFO : Completed test suite (00:20:18) 18:41:48 INFO - 2015-11-23 18:41:48,603 DEBUG : Working with test: dromaeo_css 18:41:48 INFO - 2015-11-23 18:41:48,603 DEBUG : Generating results file: dromaeo_css 18:41:48 INFO - 2015-11-23 18:41:48,604 DEBUG : Working with test: kraken 18:41:48 INFO - 2015-11-23 18:41:48,604 DEBUG : Generating results file: kraken 18:41:48 INFO - 2015-11-23 18:41:48,605 INFO : javascript benchmark 18:41:48 INFO - 2015-11-23 18:41:48,605 DEBUG : Working with test: v8_7 18:41:48 INFO - 2015-11-23 18:41:48,605 DEBUG : Generating results file: v8_7 18:41:48 INFO - 2015-11-23 18:41:48,605 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:41:48 INFO - 2015-11-23 18:41:48,664 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 18:41:48 INFO - 2015-11-23 18:41:48,664 DEBUG : process_Request line: dromaeo_css 6154.36 graph.html#tests=[[72,132,35]] 18:41:48 INFO - 2015-11-23 18:41:48,664 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:41:48 INFO - 2015-11-23 18:41:48,695 DEBUG : process_Request line: kraken 1520.30 graph.html#tests=[[232,132,35]] 18:41:48 INFO - 2015-11-23 18:41:48,695 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:41:48 INFO - 2015-11-23 18:41:48,802 DEBUG : process_Request line: v8_7 19449.39 graph.html#tests=[[230,132,35]] 18:41:48 INFO - 2015-11-23 18:41:48,803 INFO : javascript benchmark 18:41:48 INFO - 2015-11-23 18:41:48,807 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2607.674040744907, 2677.2503698964297, 2683.6377089092966, 2693.0305090167535, 2694.0974773450894, 4456.866294011184, 4605.055963527478, 4608.562186592277, 4672.0889426561835, 4692.38998930139, 4598.885027874305, 4603.7928293226805, 4645.117427688737, 4654.790534425951, 4715.434147902257, 4272.978635106828, 4320.308750599905, 4326.58897404746, 4341.913161736763, 4414.09511050234, 4375.628071613901, 4411.867643970686, 4426.645868330525, 4431.8670439886855, 4451.821927122911, 4144.357624568182, 4200.642945349649, 4247.936280955788, 4256.851010214627, 4282.935755963663, 4286.742795432284, 4292.678049146295, 4333.4366532350905, 4343.847965321199, 4385.254506733863, 4280.2081614901035, 4284.592963668447, 4291.957080429218, 4293.184294983975, 4329.328954012133, 4394.6923715339935, 4515.977420112911, 4528.139653465864, 4535.954640453586, 4598.609118224921, 4948.925766113475, 4956.504349565051, 4963.875903102451, 4972.7513624319, 4999.375078115236, 4963.900721985576, 4975.477574854624, 4984.0281145176705, 4984.327115839352, 5021.57316628087, 4485.170243504962, 4607.0785842831565, 4607.3089036644105, 4623.630109591191, 4630.8147674093, 4935.407751069823, 5005.674631149037, 5012.67417617861, 5014.247862820534, 5049.697018178921, 4896.094222568836, 4911.68074075184, 4912.238603016538, 4915.3855768029, 4960.479149689303, 4788.688735232199, 4967.105920934194, 4973.502649734997, 4977.90044199114, 4986.650934434555, 4802.73584952831, 4830.516948305141, 4851.0, 4854.781534830941, 4862.51374862518, 4760.976195119002, 4810.965642386904, 4834.709917404967, 4836.347093142451, 4864.635152363587, 4107.116969851496, 4161.500619925629, 4162.62536371728, 4189.748615083044, 4205.642520385741, 3522.2075033117344, 3627.9637203628154, 3635.654612811779, 3643.908902277464, 3671.632836716307, 4208.9789551052045, 4219.97890010548, 4274.957250427518, 4282.785860707015, 4318.827246910151, 4961.975190124099, 4966.0, 4971.130052240844, 4973.577245934136, 5015.122353588107, 4105.0763578194665, 4195.8741237762915, 4279.507856596469, 4291.163223171452, 4326.329418940069, 4278.957210427918, 4352.717073390219, 4355.934660980088, 4367.47590289161, 4368.803403846835, 4656.068786242765, 4673.088747694167, 4704.200285951465, 4720.197566413649, 4759.904801903943, 4937.654364194472, 4940.086084074458, 4956.578690811177, 4979.302897594267, 4991.550760431433, 4525.162844873709, 4695.835645752382, 4708.693934894221, 4717.150912835723, 4842.104210721028, 4916.950830491649, 4917.778699958439, 4920.557149856387, 4929.5809856161195, 4972.328735620645, 5010.7745151469, 5029.597632189343, 5030.8239211627415, 5031.195008798721, 5061.9493805061475, 4616.238320677051, 4683.555062269079, 4719.2921061841, 4719.764011799328, 4784.210605250095, 4757.048590281888, 4777.784999674954, 4779.832705855279, 4783.7129772213775, 4818.397700287464, 4685.484596694293, 4700.059988002482, 4707.529247075402, 4751.477337492804, 4752.477227505041, 4555.749433781041, 4705.176594095951, 4705.223638099676, 4765.714057156443, 4884.169691152583, 4672.883177920579, 4727.929081063856, 4731.763411829326, 4732.810687572459, 4778.689385189951], "unit": "ms", "name": "dojo.html", "value": 4538.4676871407255}, {"lowerIsBetter": false, "replicates": [540.8377486753975, 549.9340079190498, 565.6153815405523, 569.7037540478951, 574.6954114319412, 28121.859390703044, 28611.0, 36528.26943461133, 37446.812765936134, 37532.43701344475, 40418.0, 40694.0, 40757.59242407575, 40763.59236407635, 40771.59228407715, 6993.685284162199, 7816.921830781676, 7979.401544884128, 7988.600569971507, 8005.559694216816, 7078.575285482862, 7163.391111755507, 7169.85660286794, 7177.6770045348085, 9729.513524323791, 9871.555779989882, 9984.45085520296, 9994.800103997915, 9996.400215987027, 10002.799944001152, 9954.552045157949, 10067.345622534585, 10067.748306292327, 10074.445905475195, 10076.294659373847, 7122.394596459256, 7305.853882922312, 10061.496925153713, 10453.68638940833, 10457.84313235302, 36910.077248069014, 37242.0, 37259.25481490355, 37277.06807329811, 37372.43941340882, 2401.615741481372, 2410.240774156135, 2439.7194322652945, 2525.4317778499876, 2543.860087695176, 27481.587776183373, 27982.160535183975, 28114.156575302775, 28146.71853281482, 28513.0, 3396.813175275359, 3538.982305088484, 3539.50446937429, 3549.5917969433585, 3666.0651533858695, 222304.0, 223620.0, 224050.0, 224580.0, 224752.0, 44605.0, 45857.0, 56215.43784562184, 56605.71697141488, 56619.433805661414, 58839.41160588425, 59809.0, 60015.39984600098, 60082.09876851851, 60093.69953150206, 14006.579802605938, 14191.71616567663, 14201.147931123958, 14224.21766802815, 14225.502107426191, 10761.677149685522, 10837.512311945982, 10848.891511084947, 10850.67447976562, 10868.61959831402, 18726.0, 19007.80992190088, 19057.237710491703, 19161.32935347256, 19166.520836978907, 7365.300296471826, 7852.371810255166, 7860.6855725771475, 7906.248906353887, 7912.36701063925, 844.3709436469746, 882.2633101360436, 908.0102688070035, 985.5417230987625, 1032.0762917189224, 25433.237002889942, 25738.613920791202, 25760.8711956439, 26018.0, 26173.607395889077, 948.3645957208687, 951.3388195204267, 980.9656662016795, 1051.7896420715736, 1114.2089116727052, 14860.554183374516, 15290.847091528942, 15300.311485983157, 15394.535584680541, 15935.442259520862, 332530.0, 336143.0, 337408.0, 337582.0, 338093.0, 48960.26559601609, 49416.25875611797, 49446.50553494419, 49550.50449495531, 49570.50429495731, 1203.9879601204052, 1217.7686239614445, 1222.480445810527, 1222.5354365341113, 1233.5805826019196, 26664.133510654843, 26805.731942680322, 27378.178654640393, 27593.586096208976, 27742.0, 38948.221035578565, 39435.21129577335, 39480.01299967524, 39488.0, 39499.60500395074, 242427.0, 243650.0, 243706.0, 244145.0, 244326.0, 23755.52488950177, 24045.27864164078, 27929.301767455978, 28653.713462865937, 29189.85405072961, 33316.1670958228, 33656.32687346288, 44321.0, 44703.0, 45401.0, 33945.151371215914, 34252.828735856165, 34299.485507716905, 34402.48396274108, 34911.65088349084, 33952.320953581286, 34484.137896552784, 34516.30967380588, 34535.136621584665, 36880.0, 30712.53931190989, 32519.349613008082, 34603.826980864935, 34868.65131348654, 37506.0, 29259.0, 30986.225344366572, 31244.0, 31252.687473125887, 31298.843505782326, 23504.0, 23656.763432366144, 23682.38816677732, 23888.28335149948, 23985.28044158678], "unit": "ms", "name": "ext.html", "value": 17310.359562863723}, {"lowerIsBetter": false, "replicates": [319.9072269041978, 332.58925227344224, 333.2036432925307, 336.25519474364296, 339.1216748621071, 12429.378531073433, 12840.22958622481, 14971.700565988687, 15482.84517154828, 15820.288087036097, 9378.484183369912, 9678.709638710832, 9682.177014953737, 12351.629451116458, 13134.868651313507, 4616.492185859561, 4735.644826637998, 4739.0758802033615, 4746.264329029006, 4748.548887855648, 3324.2188085799817, 4650.488446270908, 4789.784459699322, 5299.390570084432, 5308.9469105308835, 5238.711870847121, 5243.947560524384, 5260.316158899338, 5260.894782104356, 5286.233496143057, 5228.372595288552, 5348.224507446418, 5579.9163012554845, 5588.077967135418, 5588.245586845785, 4922.926156107661, 4923.950760492421, 4926.33494478248, 4934.358533390672, 4936.136176169192, 17915.462536123938, 18042.548936276566, 18167.818321816743, 18308.450746477494, 18554.165062572218, 1710.4270069526724, 1746.3014794082342, 1768.1071059115066, 1805.2147315917487, 1830.8535317174594, 8979.910200897973, 9175.678851240242, 9290.581923813445, 11097.0, 12852.35738213095, 1558.8908776385545, 1647.1762340235211, 1738.7913450385909, 1740.5822602575417, 1780.8219178082218, 53860.0, 55735.0, 56467.99999999959, 56479.0, 56672.0, 9596.520173991272, 9779.902200978042, 9808.166305863939, 9839.901600983898, 9848.162906152915, 12510.31193284378, 12536.185147965352, 12539.686507837194, 12552.0, 12555.937220314023, 6601.669916504252, 6756.831079223059, 7014.579125252501, 7034.753783617549, 7101.431885449255, 6755.0, 6820.488463365168, 6838.179418469816, 6869.862602748017, 6936.063631409796, 4166.395872598457, 4210.852620158341, 4231.492220933446, 4250.06498570314, 4272.893177670583, 1579.9605009874615, 1620.5705488045678, 1632.6816270827076, 1647.8681705463534, 1712.092590926786, 385.9749116307487, 388.3611459149683, 847.8812966184739, 890.973270801877, 946.7964387656549, 9454.385464944757, 9525.952370238105, 9656.517174141265, 10017.899821001696, 10097.242706796873, 413.9399787030924, 420.155487470181, 426.1966193724789, 438.3512401645519, 440.44943820224717, 5544.86137846549, 5565.638233514808, 5640.915386269209, 5684.431556844283, 8785.604647790864, 454876.0, 456626.0, 465453.0, 468701.0, 470388.0, 67474.0, 69565.65217173983, 69851.0, 70085.0, 70251.0, 1053.4048262731533, 1069.2568664777905, 1077.272840832435, 1078.5200585739271, 1079.228351728518, 13530.93234533821, 14153.292335383396, 14569.927150364181, 14753.704925901637, 14878.181700006604, 33245.33509329848, 33498.33003339968, 33732.0, 33803.492947605315, 33858.49212261769, 41251.1749765009, 42409.0, 42793.572064280204, 42949.78525107355, 45275.0, 8770.210681038738, 8815.206631403205, 8860.911390886009, 9026.90973090287, 9051.95474022652, 10406.531706073094, 11540.596079137189, 16024.599385015468, 16272.837271627131, 16682.332706691595, 10862.565497380016, 11983.28100313984, 12913.806292905427, 13352.465901363837, 13505.054646175067, 12736.872631273569, 12820.358982051046, 12949.611511654666, 13171.143875648053, 13396.598102056954, 11101.222914395914, 11201.0, 12993.285369304778, 13660.248686322348, 14076.296185190495, 8690.565471726515, 8734.912650873664, 8738.0, 8801.867971980297, 8834.469931804113, 12586.0, 12745.426455809697, 12959.0, 13232.0, 13626.182429054288], "unit": "ms", "name": "jquery.html", "value": 7689.221898188623}, {"lowerIsBetter": false, "replicates": [1177.8233265010242, 1570.7329753941833, 1603.6872809802087, 1630.8369163083694, 1635.542048226497, 5741.339745929219, 6254.343293954137, 6400.51996100292, 6401.0, 6406.359364063591, 6532.314107018766, 6637.203535575725, 6643.501737369705, 6645.900311495331, 6648.135742353499, 1721.7331313646341, 1752.0538908989195, 1998.2706312196017, 2022.5348169920926, 2026.392082375289, 2074.0, 2078.8233000194928, 2080.8855512946857, 2082.927097551586, 2084.3538503064024, 1963.9018049097488, 1982.0783335748874, 1982.8909409982446, 1993.7308463357479, 2027.2093883385492, 1977.54516461214, 1990.9701354479694, 2021.3329601231558, 2021.7472815898086, 2043.3257025181654, 2057.4753437873246, 2084.812366886972, 2087.8538502304846, 2088.9477763055893, 2090.143041353038, 6679.799606011828, 6761.29006454325, 6778.118844550177, 6779.72881084761, 6803.251642319341, 4025.5571887092397, 4108.4453598764085, 4108.650764685005, 4114.465119534441, 4121.340585506335, 2259.1189436119926, 2636.736326367367, 2767.5848622706553, 2776.763975062122, 2787.958180627292, 818.2594751749676, 831.7962099285713, 839.8866153069318, 904.3533873280636, 944.0606596436521, 8960.0, 8967.910320896837, 8976.012638609813, 8980.730578082668, 9009.684661036832, 3835.6931445484292, 3837.884863454101, 3930.9213815723524, 3956.6043395660204, 3968.0675041365257, 7858.489198202098, 7870.842583148305, 7876.409269304825, 7883.881741773878, 7886.44794864354, 4140.979295103505, 4143.97928010364, 4144.52337981136, 4147.398627199039, 4147.440095587057, 3779.3575092234387, 3781.3760729479327, 3783.5459744830246, 3783.9243215135543, 3787.2614840105916, 2874.0, 2980.5976193214074, 3047.1772621392543, 3084.398542284233, 3281.0648965044848, 1053.8840727519967, 1079.0935614084208, 1087.798757229915, 1087.9401632910108, 1093.4314156638663, 833.0420016980399, 836.6277006731946, 836.9874451883227, 890.7505898348472, 1025.8512515685334, 6413.711382987777, 6472.385123413268, 6486.578372405778, 6489.1888513935755, 6489.1888513935755, 1000.8198524265556, 1023.97440063999, 1025.6512785652915, 1034.5758239121924, 1053.6470282455464, 4988.90022199554, 5073.315102461121, 5085.898282034413, 5093.23601459784, 5096.184610462308, 7822.256885595859, 7928.484648497829, 7977.960110199412, 8031.638576264082, 8114.350851931831, 7860.606969651494, 7890.210978902179, 7898.0, 7901.565413902291, 7976.641051152712, 6274.121622972787, 6279.183706118175, 6318.0, 6341.619502829845, 6369.936300636934, 5970.731317090828, 6123.755049797958, 6130.172426722335, 6131.478824299806, 6152.200213972155, 7126.893096603451, 7214.74748383804, 7228.7469938554, 7282.96358518204, 7283.126024877049, 7307.488475806643, 7463.0, 7465.626718663936, 7471.439642026979, 7514.436417268617, 6007.4893634039845, 6041.18444010053, 6048.395160483917, 6072.90890636632, 6073.180120683828, 5522.171674248895, 5587.804426845041, 6340.207474065742, 6375.840603984938, 6472.288048314776, 5970.522358211246, 6008.909866351921, 6026.306974697965, 6051.33435322123, 6214.067889816563, 6033.87932241344, 6042.305134909541, 6092.299385570539, 6100.969495152496, 6122.357152499102, 6003.279606447254, 6030.909536357046, 6043.75824967014, 6064.363241859542, 6204.472619827366, 5627.634203776742, 5654.462826031685, 5657.12314591239, 5663.971680141738, 5668.51817595509, 5710.114932185518, 5750.568707347049, 5772.480476756944, 5772.769089236552, 5776.335721392094], "unit": "ms", "name": "mootools.html", "value": 3903.755470633625}, {"lowerIsBetter": false, "replicates": [305.454763247603, 313.1357453428538, 317.2006543510353, 319.8496706547922, 320.6889317362158, 5217.399999000116, 5226.895462090756, 5370.91943620846, 5403.972980135099, 5414.729263536822, 5206.349206349207, 5308.575313974882, 5327.680339179652, 5338.893222135555, 5341.145416733323, 4238.894027649302, 4242.703010789246, 4242.8090735916885, 4243.787810609472, 4246.957530424703, 4016.5581786003518, 4099.3441049432095, 4120.505539335284, 4215.978920105395, 4239.152169566084, 4195.412642230091, 4199.538050814408, 4201.285781417151, 4207.663386929054, 4224.197402493532, 4191.7484950903045, 4207.326827707552, 4207.873763787076, 4213.325867861127, 4221.092465119983, 3738.607446218135, 3744.101415660249, 3744.1762812181278, 3752.3433399155037, 3754.3242216401036, 4805.1864243555665, 4927.601246105919, 5185.455527169668, 5192.091384007784, 5195.558377537914, 3987.581303963071, 4533.909321813545, 4756.405449318835, 4758.904821903578, 4765.809367625291, 5518.172274158868, 5575.665460072409, 5591.2731344925305, 5592.664440133564, 5595.63628364155, 3719.0702324418894, 3787.8484860605545, 3798.525184351956, 3824.8278827452555, 3843.5195600549932, 5859.326177489601, 5925.40745925404, 5925.73334199962, 5936.5250779937505, 5939.970300148515, 4062.5734297898293, 4064.695147863922, 4066.9796651016554, 4067.7762723049923, 4069.2675318442966, 4114.403411505375, 4123.0516981094515, 4123.814428350672, 4126.051008268055, 4127.071408932966, 4553.908921821611, 4681.063787242565, 4707.152712511781, 4708.128996135657, 4719.5752382285755, 5637.49262566371, 5639.943600563942, 5640.633358831745, 5642.830715078554, 5642.887142257132, 1442.213993373614, 1460.2990564529086, 1460.9342579583945, 1461.4300422835104, 1463.6926245488353, 982.6167794560128, 985.6254623243265, 988.8269552828226, 1003.6336737090909, 1009.5406590001678, 4947.431045429749, 4952.232403977389, 4953.182724850431, 4956.479569645207, 4960.627952903546, 5849.298084229919, 5850.063989761703, 5850.385709500526, 5853.239078919798, 5858.121281807763, 4935.87660308488, 4953.23224900141, 4956.504349565014, 4957.20684690455, 4961.355023846877, 3051.1456792098247, 3125.2655625927887, 3132.4674805283157, 3133.2793457504445, 3151.9842400788307, 5550.084236101079, 5565.053940830068, 5567.777288908479, 5578.0, 5580.832575022756, 6064.120702498113, 6065.5450841187085, 6067.362926892612, 6070.3019152798, 6073.635581865014, 5573.860653483614, 5574.693391863405, 5575.107982722745, 5577.163425486128, 5580.888382232414, 5681.8863622726485, 5842.065269556851, 5863.589548731547, 5896.764129434775, 5940.108983652487, 5537.584681148849, 5685.914711279252, 5769.59612827098, 5780.884382312414, 5781.219535362672, 5398.2712333836, 5539.446055394428, 5551.195076713773, 5576.637518561281, 5579.13523403873, 4037.93943090848, 4086.530049044398, 4087.3051581231857, 4087.6116768906904, 4093.9385909211983, 5845.473907348359, 5896.823095306976, 5899.115132730125, 5905.940940590711, 5907.586468947133, 5466.945330546644, 5615.859603509945, 5662.433756624469, 5672.404397538364, 5672.461116193955, 5647.1529270609735, 5655.236543066798, 5655.915161272502, 5658.886822263614, 5661.065924122474, 5510.8071217507195, 5521.199426083276, 5545.279113715191, 5549.278593782782, 5550.500454959073, 5516.448355164452, 5656.943430565641, 5659.0, 5723.6851973141875, 5734.082546792493, 5569.10894256917, 5572.0, 5575.721213939206, 5578.916316255179, 5583.302087239095], "unit": "ms", "name": "prototype.html", "value": 4244.516733359017}, {"lowerIsBetter": false, "replicates": [619.0126747837198, 693.337862341464, 702.8769965256081, 723.3959643697513, 768.5772824946282, 10452.79094418112, 10842.945785271073, 10854.837177442345, 10868.402237876913, 10870.836937445945, 12215.144939854214, 12327.383630818467, 12332.075094367914, 12342.32117233554, 12356.135070545066, 602.1509671363378, 754.5548126605302, 770.8882212079245, 771.6874665760377, 771.7298945369104, 602.8944934636443, 610.5237914426732, 611.7063809371505, 730.262434940711, 753.1338960195791, 794.8608993426157, 796.6693822063866, 803.0443771911436, 803.1566854802463, 803.4135081390589, 797.5453991225004, 798.9161138080505, 799.0, 799.4443861516248, 799.448380617375, 463.47395705873737, 468.9859304220879, 469.7463369780315, 574.9827505174851, 588.3322429043067, 11543.249688770287, 11593.76812463746, 11663.708407289801, 11668.88331116695, 11703.824442633368, 10884.0, 11073.889261107366, 11117.0, 11121.0, 11511.079113670887, 8893.377463577552, 9149.45103293798, 9330.860037099448, 9421.38760980534, 9451.480168590724, 3195.5206718992104, 3211.245357341023, 3265.951010734841, 3288.638249792521, 3340.983295083509, 38934.02664933371, 39126.41310380347, 39475.0, 39490.210195795924, 39547.0, 8837.734867953972, 9224.492652904155, 9422.811543769087, 9587.18508926735, 9795.167410770022, 16181.19094045293, 16195.838041619669, 16199.919000404923, 16204.59488512773, 16215.513534593982, 6023.578349515579, 6259.593126446766, 6275.309715931244, 6332.905006424908, 6437.034444833313, 3392.6098498672477, 3452.4648679454726, 3564.4475106358555, 3614.8192590370377, 3692.48305237267, 2681.865906704657, 2698.311930457721, 2699.987504685743, 2701.648785657852, 2703.986480067587, 461.35871139116654, 462.51667007976744, 475.728834564295, 484.33162236113935, 485.1921550618252, 398.81654438958407, 421.2417648233168, 432.53502484828937, 439.53628921487496, 605.8364241654816, 6547.985062315349, 6777.559458635173, 6888.138982627172, 6964.965175174193, 7181.928180718231, 403.6972270796902, 427.2395136656756, 439.97140185887815, 452.127394129327, 483.9954866678561, 3041.1788817019283, 3162.9525557116663, 3408.2331475418327, 3482.094655389617, 3531.0, 47756.28365574519, 48546.27180592294, 48603.0, 48702.75648621734, 53487.0, 45008.77495612501, 46113.308300375524, 47213.0, 47325.0, 47864.282035769495, 42947.57052429436, 43666.0, 44116.77941610335, 44416.0, 44439.4452942994, 6758.290379510081, 7295.416366690758, 7617.542947423172, 7682.500637458547, 7957.204279571996, 30415.0, 31218.687813121578, 31308.530372044894, 31344.843275783474, 31594.842025790644, 37744.0, 40714.38928416017, 41560.1687966245, 42073.579264206965, 42422.0, 8937.374383793072, 9072.520377050014, 9144.679936202201, 9184.954075229849, 9216.493092879688, 10367.118794902517, 10563.841542377024, 10590.311629744043, 10594.467918195458, 10684.946575267073, 10119.0, 10265.486725663837, 10671.306365086244, 10676.412797296223, 10716.19628527848, 9326.440413575207, 9650.324477286522, 9678.419294842332, 9846.31075824714, 9927.900720992986, 9669.371490853073, 9970.052844979715, 10167.796644067224, 10495.685129446128, 10523.894761052292, 7850.6074696266105, 7870.9606451967375, 8046.436749427484, 8184.0, 8215.260626543639, 7608.429367797326, 7795.337396321376, 7880.527168369917, 8027.438079334391, 8133.0], "unit": "ms", "name": "yui.html", "value": 5428.009989234332}], "name": "dromaeo_css", "value": 6154.358273551833}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 116.0, 109.0, 112.0, 112.0, 114.0, 103.0, 114.0, 112.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [153.0, 130.0, 160.0, 172.0, 132.0, 154.0, 151.0, 134.0, 168.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.3}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 162.0, 159.0, 160.0, 159.0, 161.0, 160.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 86.0, 90.0, 71.0, 71.0, 72.0, 102.0, 89.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 131.0, 94.0, 94.0, 93.0, 135.0, 94.0, 94.0, 127.0], "unit": "ms", "name": "audio-oscillator", "value": 105.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 70.0, 70.0, 71.0, 70.0, 79.0, 68.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 70.7}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 67.0, 68.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [90.0, 83.0, 84.0, 83.0, 84.0, 83.0, 89.0, 83.0, 85.0, 92.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [125.0, 120.0, 128.0, 119.0, 127.0, 122.0, 123.0, 130.0, 129.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [151.0, 148.0, 153.0, 148.0, 147.0, 135.0, 136.0, 152.0, 155.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.1}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 71.0, 69.0, 69.0, 67.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1520.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [200.0], "unit": "score", "name": "Richards", "value": 176.51}, {"lowerIsBetter": false, "replicates": [191.79133103183736], "unit": "score", "name": "DeltaBlue", "value": 344.73925199999996}, {"lowerIsBetter": false, "replicates": [279.4857462269424], "unit": "score", "name": "Encrypt", "value": 952.3956179999999}, {"lowerIsBetter": false, "replicates": [5000.0], "unit": "score", "name": "Decrypt", "value": 53.23619999999997}, {"lowerIsBetter": false, "replicates": [1980.1980198019803], "unit": "score", "name": "RayTrace", "value": 373.6944450000001}, {"lowerIsBetter": false, "replicates": [796.8127490039841], "unit": "score", "name": "Earley", "value": 836.4110649999999}, {"lowerIsBetter": false, "replicates": [11952.380952380952], "unit": "score", "name": "Boyer", "value": 55.75985258964142}, {"lowerIsBetter": false, "replicates": [26973.684210526317], "unit": "score", "name": "RegExp", "value": 33.77310243902437}, {"lowerIsBetter": false, "replicates": [609.2995169082126], "unit": "score", "name": "Splay", "value": 133.74538751238845}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19449.38740281947}]} 18:41:48 INFO - RETURN: dromaeo_css: 6154.36 18:41:48 INFO - RETURN: kraken: 1520.30 18:41:48 INFO - RETURN: v8_7: 19449.39 18:41:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19449.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1520.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6154.36"}}} 18:41:48 INFO - Return code: 0 18:41:48 INFO - # TBPL SUCCESS # 18:41:48 INFO - Running post-action listener: _resource_record_post_action 18:41:48 INFO - Running post-run listener: _resource_record_post_run 18:41:49 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 10395648; Write bytes: 406593536; Read time: 2456; Write time: 310988 18:41:49 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 9580544; Read time: 0; Write time: 808 18:41:49 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 8167424; Write bytes: 397012992; Read time: 2284; Write time: 310180 18:41:49 INFO - Running post-run listener: _upload_blobber_files 18:41:49 INFO - Blob upload gear active. 18:41:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:41:49 INFO - Copying logs to upload dir... 18:41:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1275.132270 ========= master_lag: 0.43 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-11-23 18:41:50.075693) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:50.078732) ========= 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=820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009853 build_url: 'https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:50.129269) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:50.129602) ========= 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=820bb6602ddf640013a48df2000001a9-1448331554.549241-2132664176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:50.179261) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 18:41:50.179571) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 18:41:50.179880) ========= ========= Total master_lag: 0.66 =========