builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1449059159.39 results: success (0) buildid: 20151127103731 builduid: 3f081eb818b04624a3a075611ac903f2 revision: f48352b311eb120a09347efce60ae9045401858c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 04:25:59.390804) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 04:25:59.391417) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 04:25:59.391786) ========= 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=d333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004021 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 04:25:59.408978) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 04:25:59.409455) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 04:25:59.423626) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 04:25:59.424117) ========= 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=d333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004626 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 04:25:59.474318) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 04:25:59.474639) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 04:25:59.474998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 04:25:59.475267) ========= 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=d333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-02 04:26:00-- 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% 40.3M=0s 2015-12-02 04:26:00 (40.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160017 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 04:25:59.648685) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 04:25:59.649072) ========= 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=d333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022375 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 04:25:59.699923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 04:25:59.700358) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f48352b311eb120a09347efce60ae9045401858c --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 f48352b311eb120a09347efce60ae9045401858c --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=d333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-02 04:26:00,712 truncating revision to first 12 chars 2015-12-02 04:26:00,712 Setting DEBUG logging. 2015-12-02 04:26:00,712 attempt 1/10 2015-12-02 04:26:00,712 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f48352b311eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-02 04:26:00,963 unpacking tar archive at: fx-team-f48352b311eb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.533291 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 04:26:00.249152) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 04:26:00.249547) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 04:26:00.261516) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 04:26:00.262096) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 04:26:00.262846) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-02 04:26:00.263371) ========= /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=d333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:26:01 INFO - MultiFileLogger online at 20151202 04:26:01 in /builds/slave/test 04:26:01 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 04:26:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:26:01 INFO - {'append_to_log': False, 04:26:01 INFO - 'base_work_dir': '/builds/slave/test', 04:26:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:26:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:26:01 INFO - 'branch': 'Fx-Team-Non-PGO', 04:26:01 INFO - 'buildbot_json_path': 'buildprops.json', 04:26:01 INFO - 'config_files': ('talos/linux_config.py',), 04:26:01 INFO - 'default_actions': ('clobber', 04:26:01 INFO - 'read-buildbot-config', 04:26:01 INFO - 'download-and-extract', 04:26:01 INFO - 'populate-webroot', 04:26:01 INFO - 'create-virtualenv', 04:26:01 INFO - 'install', 04:26:01 INFO - 'run-tests'), 04:26:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:26:01 INFO - 'download_minidump_stackwalk': True, 04:26:01 INFO - 'download_symbols': 'ondemand', 04:26:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:26:01 INFO - 'tooltool.py': '/tools/tooltool.py', 04:26:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:26:01 INFO - '/tools/misc-python/virtualenv.py')}, 04:26:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:26:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:26:01 INFO - 'installer_path': 'installer.exe', 04:26:01 INFO - 'log_level': 'info', 04:26:01 INFO - 'log_name': 'talos', 04:26:01 INFO - 'log_to_console': True, 04:26:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:26:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:26:01 INFO - 'opt_config_files': (), 04:26:01 INFO - 'pip_index': False, 04:26:01 INFO - 'sps_profile': False, 04:26:01 INFO - 'sps_profile_interval': 0, 04:26:01 INFO - 'suite': 'dromaeojs', 04:26:01 INFO - 'system_bits': '64', 04:26:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:26:01 INFO - 'title': 'talos-linux64-ix-051', 04:26:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:26:01 INFO - 'use_talos_json': True, 04:26:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:26:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:26:01 INFO - 'work_dir': 'build'} 04:26:01 INFO - ##### 04:26:01 INFO - ##### Running clobber step. 04:26:01 INFO - ##### 04:26:01 INFO - Running pre-action listener: _resource_record_pre_action 04:26:01 INFO - Running main action method: clobber 04:26:01 INFO - rmtree: /builds/slave/test/build 04:26:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:26:02 INFO - Running post-action listener: _resource_record_post_action 04:26:02 INFO - ##### 04:26:02 INFO - ##### Running read-buildbot-config step. 04:26:02 INFO - ##### 04:26:02 INFO - Running pre-action listener: _resource_record_pre_action 04:26:02 INFO - Running main action method: read_buildbot_config 04:26:02 INFO - Using buildbot properties: 04:26:02 INFO - { 04:26:02 INFO - "properties": { 04:26:02 INFO - "buildnumber": 962, 04:26:02 INFO - "product": "firefox", 04:26:02 INFO - "script_repo_revision": "production", 04:26:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:26:02 INFO - "repository": "", 04:26:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:26:02 INFO - "buildid": "20151127103731", 04:26:02 INFO - "slavename": "talos-linux64-ix-051", 04:26:02 INFO - "pgo_build": "False", 04:26:02 INFO - "basedir": "/builds/slave/test", 04:26:02 INFO - "project": "", 04:26:02 INFO - "platform": "ubuntu64_hw", 04:26:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:26:02 INFO - "slavebuilddir": "test", 04:26:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:26:02 INFO - "branch": "fx-team", 04:26:02 INFO - "repo_path": "integration/fx-team", 04:26:02 INFO - "stage_platform": "linux64", 04:26:02 INFO - "builduid": "3f081eb818b04624a3a075611ac903f2", 04:26:02 INFO - "revision": "f48352b311eb120a09347efce60ae9045401858c" 04:26:02 INFO - }, 04:26:02 INFO - "sourcestamp": { 04:26:02 INFO - "repository": "", 04:26:02 INFO - "hasPatch": false, 04:26:02 INFO - "project": "", 04:26:02 INFO - "branch": "fx-team-linux64-talos", 04:26:02 INFO - "changes": [ 04:26:02 INFO - { 04:26:02 INFO - "category": null, 04:26:02 INFO - "files": [ 04:26:02 INFO - { 04:26:02 INFO - "url": null, 04:26:02 INFO - "name": "https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:26:02 INFO - } 04:26:02 INFO - ], 04:26:02 INFO - "repository": "", 04:26:02 INFO - "rev": "f48352b311eb120a09347efce60ae9045401858c", 04:26:02 INFO - "who": "mbanner@mozilla.com", 04:26:02 INFO - "when": 1448651775, 04:26:02 INFO - "number": 6715644, 04:26:02 INFO - "comments": "Backout changeset 958669938c10 / bug 1225832 due to frequent mochitest failures on Mac", 04:26:02 INFO - "project": "", 04:26:02 INFO - "at": "Fri 27 Nov 2015 11:16:15", 04:26:02 INFO - "branch": "fx-team-linux64-talos", 04:26:02 INFO - "revlink": "", 04:26:02 INFO - "properties": [ 04:26:02 INFO - [ 04:26:02 INFO - "buildid", 04:26:02 INFO - "20151127103731", 04:26:02 INFO - "Change" 04:26:02 INFO - ], 04:26:02 INFO - [ 04:26:02 INFO - "builduid", 04:26:02 INFO - "3f081eb818b04624a3a075611ac903f2", 04:26:02 INFO - "Change" 04:26:02 INFO - ], 04:26:02 INFO - [ 04:26:02 INFO - "pgo_build", 04:26:02 INFO - "False", 04:26:02 INFO - "Change" 04:26:02 INFO - ] 04:26:02 INFO - ], 04:26:02 INFO - "revision": "f48352b311eb120a09347efce60ae9045401858c" 04:26:02 INFO - } 04:26:02 INFO - ], 04:26:02 INFO - "revision": "f48352b311eb120a09347efce60ae9045401858c" 04:26:02 INFO - } 04:26:02 INFO - } 04:26:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:26:02 INFO - Running post-action listener: _resource_record_post_action 04:26:02 INFO - ##### 04:26:02 INFO - ##### Running download-and-extract step. 04:26:02 INFO - ##### 04:26:02 INFO - Running pre-action listener: _resource_record_pre_action 04:26:02 INFO - Running main action method: download_and_extract 04:26:02 INFO - mkdir: /builds/slave/test/build/tests 04:26: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')]} 04:26:02 INFO - https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:26:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/test_packages.json 04:26:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/test_packages.json 04:26:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:26:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:26:02 INFO - Downloaded 1302 bytes. 04:26:02 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:26:02 INFO - Using the following test package requirements: 04:26:02 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:02 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:02 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:26:02 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:02 INFO - u'jsshell-linux-x86_64.zip'], 04:26:02 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:02 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:26:02 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:02 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:02 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:26:02 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:02 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:26:02 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:02 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:26:02 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:02 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:02 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:26:02 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:26: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')]} 04:26:02 INFO - https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:26:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:26:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:26:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/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 04:26:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/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 04:26:04 INFO - Downloaded 21517181 bytes. 04:26:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:26:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:26:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:26:05 INFO - Return code: 0 04:26:05 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 04:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:05 INFO - https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:26:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:26:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:26:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/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 04:26:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/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 04:26:06 INFO - Downloaded 21517181 bytes. 04:26:06 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 04:26:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:26:06 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 04:26:07 INFO - Return code: 0 04:26: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')]} 04:26:07 INFO - https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:26:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:26:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:26:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/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 04:26:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/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 04:26:08 INFO - Downloaded 11131728 bytes. 04:26:08 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 04:26:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:26:08 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 04:26:08 INFO - Return code: 0 04:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:08 INFO - https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:26:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:26:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:26:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/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 04:26:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/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 04:26:09 INFO - Downloaded 56872327 bytes. 04:26:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:26:09 INFO - mkdir: /builds/slave/test/properties 04:26:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:26:09 INFO - Writing to file /builds/slave/test/properties/build_url 04:26:09 INFO - Contents: 04:26:09 INFO - build_url:https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:26:09 INFO - Running post-action listener: _resource_record_post_action 04:26:09 INFO - Running post-action listener: set_extra_try_arguments 04:26:09 INFO - ##### 04:26:09 INFO - ##### Running populate-webroot step. 04:26:09 INFO - ##### 04:26:09 INFO - Running pre-action listener: _resource_record_pre_action 04:26:09 INFO - Running main action method: populate_webroot 04:26:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:26:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:26:09 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:26:09 INFO - '../fennec_ids.txt'], 04:26:09 INFO - 'tests': ['tcheck2']}, 04:26:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:26:09 INFO - '--tppagecycles', 04:26:09 INFO - '7'], 04:26:09 INFO - 'tests': ['tsvgm']}}, 04:26:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:26:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:26:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:26:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:26:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:26:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:26:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:09 INFO - 'talos_options': ['--e10s'], 04:26:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:09 INFO - 'tests': ['damp', 'tps']}, 04:26:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:09 INFO - 'talos_options': ['--e10s'], 04:26:09 INFO - 'tests': ['damp', 'tps']}, 04:26:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:26:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:26:09 INFO - 'other': {'tests': ['a11yr', 04:26:09 INFO - 'ts_paint', 04:26:09 INFO - 'tpaint', 04:26:09 INFO - 'sessionrestore', 04:26:09 INFO - 'sessionrestore_no_auto_restore']}, 04:26:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:26:09 INFO - 'tests': ['a11yr', 04:26:09 INFO - 'ts_paint', 04:26:09 INFO - 'tpaint', 04:26:09 INFO - 'sessionrestore', 04:26:09 INFO - 'sessionrestore_no_auto_restore']}, 04:26:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:26:09 INFO - 'tests': ['a11yr', 04:26:09 INFO - 'ts_paint', 04:26:09 INFO - 'tpaint', 04:26:09 INFO - 'sessionrestore', 04:26:09 INFO - 'sessionrestore_no_auto_restore']}, 04:26:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:26:09 INFO - 'tests': ['a11yr', 04:26:09 INFO - 'ts_paint', 04:26:09 INFO - 'tpaint', 04:26:09 INFO - 'sessionrestore', 04:26:09 INFO - 'sessionrestore_no_auto_restore']}, 04:26:09 INFO - 'other_l64': {'tests': ['a11yr', 04:26:09 INFO - 'ts_paint', 04:26:09 INFO - 'tpaint', 04:26:09 INFO - 'sessionrestore', 04:26:09 INFO - 'sessionrestore_no_auto_restore']}, 04:26:09 INFO - 'other_nol64': {'tests': ['a11yr', 04:26:09 INFO - 'ts_paint', 04:26:09 INFO - 'tpaint', 04:26:09 INFO - 'sessionrestore', 04:26:09 INFO - 'sessionrestore_no_auto_restore']}, 04:26:09 INFO - 'svgr': {'tests': ['tsvgx', 04:26:09 INFO - 'tsvgr_opacity', 04:26:09 INFO - 'tart', 04:26:09 INFO - 'tscrollx', 04:26:09 INFO - 'cart']}, 04:26:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:26:09 INFO - 'tests': ['tsvgx', 04:26:09 INFO - 'tsvgr_opacity', 04:26:09 INFO - 'tart', 04:26:09 INFO - 'tscrollx', 04:26:09 INFO - 'cart']}, 04:26:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:09 INFO - 'tests': ['tp5o']}, 04:26:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:09 INFO - 'talos_options': ['--e10s'], 04:26:09 INFO - 'tests': ['tp5o']}, 04:26:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:09 INFO - 'talos_options': ['--xperf_path', 04:26:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:09 INFO - 'tests': ['tp5n']}, 04:26:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:09 INFO - 'talos_options': ['--e10s', 04:26:09 INFO - '--xperf_path', 04:26:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:09 INFO - 'tests': ['tp5n']}}, 04:26:09 INFO - 'talos.zip': {'path': '', 04:26:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:26:09 INFO - Running post-action listener: _resource_record_post_action 04:26:09 INFO - ##### 04:26:09 INFO - ##### Running create-virtualenv step. 04:26:09 INFO - ##### 04:26:09 INFO - Running pre-action listener: _resource_record_pre_action 04:26:09 INFO - Running main action method: create_virtualenv 04:26:09 INFO - Creating virtualenv /builds/slave/test/build/venv 04:26:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:26:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:26:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:26:10 INFO - Using real prefix '/usr' 04:26:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:26:10 INFO - Installing distribute.............................................................................................................................................................................................done. 04:26:12 INFO - Installing pip.................done. 04:26:12 INFO - Return code: 0 04:26:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75a8dcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x161f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae0b0>, '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 0x16aefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16af440>, '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': 'd333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219', '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 04:26:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:26:12 INFO - Using env: {'DISPLAY': ':0', 04:26:12 INFO - 'HOME': '/home/cltbld', 04:26:12 INFO - 'LANG': 'en_US.UTF-8', 04:26:12 INFO - 'LANGUAGE': 'en_US:en', 04:26:12 INFO - 'LOGNAME': 'cltbld', 04:26:12 INFO - 'MAIL': '/var/mail/cltbld', 04:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:12 INFO - 'MOZ_NO_REMOTE': '1', 04:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:12 INFO - 'NO_EM_RESTART': '1', 04:26:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:12 INFO - 'PWD': '/builds/slave/test', 04:26:12 INFO - 'SHELL': '/bin/bash', 04:26:12 INFO - 'SHLVL': '1', 04:26:12 INFO - 'TERM': 'linux', 04:26:12 INFO - 'TMOUT': '86400', 04:26:12 INFO - 'USER': 'cltbld', 04:26:12 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219', 04:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:12 INFO - '_': '/tools/buildbot/bin/python'} 04:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:26:12 INFO - Cleaning up... 04:26:12 INFO - Return code: 0 04:26:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75a8dcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x161f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae0b0>, '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 0x16aefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16af440>, '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': 'd333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219', '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 04:26:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:26:12 INFO - Using env: {'DISPLAY': ':0', 04:26:12 INFO - 'HOME': '/home/cltbld', 04:26:12 INFO - 'LANG': 'en_US.UTF-8', 04:26:12 INFO - 'LANGUAGE': 'en_US:en', 04:26:12 INFO - 'LOGNAME': 'cltbld', 04:26:12 INFO - 'MAIL': '/var/mail/cltbld', 04:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:12 INFO - 'MOZ_NO_REMOTE': '1', 04:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:12 INFO - 'NO_EM_RESTART': '1', 04:26:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:12 INFO - 'PWD': '/builds/slave/test', 04:26:12 INFO - 'SHELL': '/bin/bash', 04:26:12 INFO - 'SHLVL': '1', 04:26:12 INFO - 'TERM': 'linux', 04:26:12 INFO - 'TMOUT': '86400', 04:26:12 INFO - 'USER': 'cltbld', 04:26:12 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219', 04:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:12 INFO - '_': '/tools/buildbot/bin/python'} 04:26:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:13 INFO - Downloading/unpacking psutil>=0.7.1 04:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:14 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:26:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:26:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:26:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:26:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:26:14 INFO - Installing collected packages: psutil 04:26:14 INFO - Running setup.py install for psutil 04:26:14 INFO - building 'psutil._psutil_linux' extension 04:26:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:26:15 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 04:26:15 INFO - building 'psutil._psutil_posix' extension 04:26:15 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 04:26:15 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 04:26:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:26:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:26:15 INFO - Successfully installed psutil 04:26:15 INFO - Cleaning up... 04:26:15 INFO - Return code: 0 04:26:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f75a8dcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x161f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae0b0>, '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 0x16aefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16af440>, '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': 'd333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219', '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 04:26:15 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 04:26:15 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 04:26:15 INFO - Using env: {'DISPLAY': ':0', 04:26:15 INFO - 'HOME': '/home/cltbld', 04:26:15 INFO - 'LANG': 'en_US.UTF-8', 04:26:15 INFO - 'LANGUAGE': 'en_US:en', 04:26:15 INFO - 'LOGNAME': 'cltbld', 04:26:15 INFO - 'MAIL': '/var/mail/cltbld', 04:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:15 INFO - 'MOZ_NO_REMOTE': '1', 04:26:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:15 INFO - 'NO_EM_RESTART': '1', 04:26:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:15 INFO - 'PWD': '/builds/slave/test', 04:26:15 INFO - 'SHELL': '/bin/bash', 04:26:15 INFO - 'SHLVL': '1', 04:26:15 INFO - 'TERM': 'linux', 04:26:15 INFO - 'TMOUT': '86400', 04:26:15 INFO - 'USER': 'cltbld', 04:26:15 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219', 04:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:15 INFO - '_': '/tools/buildbot/bin/python'} 04:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:26:15 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 04:26:15 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 04:26:15 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 04:26:15 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 04:26:15 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 04:26:15 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 04:26:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:26:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:26:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:26:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:26:17 INFO - Installing collected packages: mozsystemmonitor 04:26:17 INFO - Running setup.py install for mozsystemmonitor 04:26:17 INFO - Successfully installed mozsystemmonitor 04:26:17 INFO - Cleaning up... 04:26:17 INFO - Return code: 0 04:26:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:26:17 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')]} 04:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:17 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')]} 04:26:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:17 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 0x7f75a8dcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x161f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae0b0>, '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 0x16aefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16af440>, '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': 'd333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219', '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 04:26:17 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 04:26:17 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 04:26:17 INFO - Using env: {'DISPLAY': ':0', 04:26:17 INFO - 'HOME': '/home/cltbld', 04:26:17 INFO - 'LANG': 'en_US.UTF-8', 04:26:17 INFO - 'LANGUAGE': 'en_US:en', 04:26:17 INFO - 'LOGNAME': 'cltbld', 04:26:17 INFO - 'MAIL': '/var/mail/cltbld', 04:26:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:17 INFO - 'MOZ_NO_REMOTE': '1', 04:26:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:17 INFO - 'NO_EM_RESTART': '1', 04:26:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:17 INFO - 'PWD': '/builds/slave/test', 04:26:17 INFO - 'SHELL': '/bin/bash', 04:26:17 INFO - 'SHLVL': '1', 04:26:17 INFO - 'TERM': 'linux', 04:26:17 INFO - 'TMOUT': '86400', 04:26:17 INFO - 'USER': 'cltbld', 04:26:17 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219', 04:26:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:17 INFO - '_': '/tools/buildbot/bin/python'} 04:26:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:17 INFO - Downloading/unpacking blobuploader==1.2.4 04:26:17 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 04:26:17 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 04:26:17 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 04:26:17 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 04:26:17 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 04:26:17 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 04:26:19 INFO - Downloading blobuploader-1.2.4.tar.gz 04:26:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:26:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:26:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:26:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:26:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:20 INFO - Downloading docopt-0.6.1.tar.gz 04:26:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:26:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:26:20 INFO - Installing collected packages: blobuploader, requests, docopt 04:26:20 INFO - Running setup.py install for blobuploader 04:26:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:26:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:26:20 INFO - Running setup.py install for requests 04:26:20 INFO - Running setup.py install for docopt 04:26:20 INFO - Successfully installed blobuploader requests docopt 04:26:20 INFO - Cleaning up... 04:26:20 INFO - Return code: 0 04:26:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:20 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')]} 04:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:20 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')]} 04:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:20 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 0x7f75a8dcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x161f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae0b0>, '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 0x16aefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16af440>, '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': 'd333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219', '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 04:26:20 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 04:26:20 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 04:26:20 INFO - Using env: {'DISPLAY': ':0', 04:26:20 INFO - 'HOME': '/home/cltbld', 04:26:20 INFO - 'LANG': 'en_US.UTF-8', 04:26:20 INFO - 'LANGUAGE': 'en_US:en', 04:26:20 INFO - 'LOGNAME': 'cltbld', 04:26:20 INFO - 'MAIL': '/var/mail/cltbld', 04:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:20 INFO - 'MOZ_NO_REMOTE': '1', 04:26:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:20 INFO - 'NO_EM_RESTART': '1', 04:26:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:20 INFO - 'PWD': '/builds/slave/test', 04:26:20 INFO - 'SHELL': '/bin/bash', 04:26:20 INFO - 'SHLVL': '1', 04:26:20 INFO - 'TERM': 'linux', 04:26:20 INFO - 'TMOUT': '86400', 04:26:20 INFO - 'USER': 'cltbld', 04:26:20 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219', 04:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:20 INFO - '_': '/tools/buildbot/bin/python'} 04:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:26:20 INFO - Running setup.py (path:/tmp/pip-gJrzkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:26:21 INFO - Running setup.py (path:/tmp/pip-9wLrjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:26:21 INFO - Running setup.py (path:/tmp/pip-FxKU30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:26:21 INFO - Running setup.py (path:/tmp/pip-yGHkrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:26:21 INFO - Running setup.py (path:/tmp/pip-lbzroO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:26:21 INFO - Running setup.py (path:/tmp/pip-dbsqXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:26:21 INFO - Running setup.py (path:/tmp/pip-B8grGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:26:21 INFO - Running setup.py (path:/tmp/pip-EQJeIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:26:21 INFO - Running setup.py (path:/tmp/pip-sxDI1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:21 INFO - Running setup.py (path:/tmp/pip-cOR9Gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:21 INFO - Running setup.py (path:/tmp/pip-BDSlI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:21 INFO - Running setup.py (path:/tmp/pip-yBglEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:21 INFO - Running setup.py (path:/tmp/pip-430sdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:21 INFO - Running setup.py (path:/tmp/pip-m1MGlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:22 INFO - Running setup.py (path:/tmp/pip-0Mg7Y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:22 INFO - Running setup.py (path:/tmp/pip-QR2bXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:22 INFO - Running setup.py (path:/tmp/pip-UT4B5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:26:22 INFO - Running setup.py install for manifestparser 04:26:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:26:22 INFO - Running setup.py install for mozcrash 04:26:22 INFO - Running setup.py install for mozdebug 04:26:22 INFO - Running setup.py install for mozdevice 04:26:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:26:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:26:22 INFO - Running setup.py install for mozfile 04:26:22 INFO - Running setup.py install for mozhttpd 04:26:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:26:22 INFO - Running setup.py install for mozinfo 04:26:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:26:22 INFO - Running setup.py install for mozInstall 04:26:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:26:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:26:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:26:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:26:23 INFO - Running setup.py install for mozleak 04:26:23 INFO - Running setup.py install for mozlog 04:26:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:26:23 INFO - Running setup.py install for moznetwork 04:26:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:26:23 INFO - Running setup.py install for mozprocess 04:26:23 INFO - Running setup.py install for mozprofile 04:26:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:26:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:26:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:26:23 INFO - Running setup.py install for mozrunner 04:26:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:26:23 INFO - Running setup.py install for mozscreenshot 04:26:23 INFO - Running setup.py install for moztest 04:26:23 INFO - Running setup.py install for mozversion 04:26:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:26:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:26:23 INFO - Cleaning up... 04:26:23 INFO - Return code: 0 04:26:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75a8dcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x161f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae0b0>, '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 0x16aefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16af440>, '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': 'd333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219', '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 04:26:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:26:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:26:23 INFO - Using env: {'DISPLAY': ':0', 04:26:23 INFO - 'HOME': '/home/cltbld', 04:26:23 INFO - 'LANG': 'en_US.UTF-8', 04:26:23 INFO - 'LANGUAGE': 'en_US:en', 04:26:23 INFO - 'LOGNAME': 'cltbld', 04:26:23 INFO - 'MAIL': '/var/mail/cltbld', 04:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:23 INFO - 'MOZ_NO_REMOTE': '1', 04:26:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:23 INFO - 'NO_EM_RESTART': '1', 04:26:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:23 INFO - 'PWD': '/builds/slave/test', 04:26:23 INFO - 'SHELL': '/bin/bash', 04:26:23 INFO - 'SHLVL': '1', 04:26:23 INFO - 'TERM': 'linux', 04:26:23 INFO - 'TMOUT': '86400', 04:26:23 INFO - 'USER': 'cltbld', 04:26:23 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219', 04:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:23 INFO - '_': '/tools/buildbot/bin/python'} 04:26:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:26:24 INFO - Running setup.py (path:/tmp/pip-wk5kwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:26:24 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)) 04:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:26:24 INFO - Running setup.py (path:/tmp/pip-Vl21Hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:26:24 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)) 04:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:26:24 INFO - Running setup.py (path:/tmp/pip-JI3rDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:26:24 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)) 04:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:26:24 INFO - Running setup.py (path:/tmp/pip-02gijh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:26:24 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)) 04:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:26:24 INFO - Running setup.py (path:/tmp/pip-GJrHwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:26:24 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)) 04:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:26:24 INFO - Running setup.py (path:/tmp/pip-5AL7kO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:26:24 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)) 04:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:26:24 INFO - Running setup.py (path:/tmp/pip-jeaGJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:26:24 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)) 04:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:26:24 INFO - Running setup.py (path:/tmp/pip-WSOvCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:26:24 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)) 04:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:26:24 INFO - Running setup.py (path:/tmp/pip-ZA0dTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:24 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)) 04:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:24 INFO - Running setup.py (path:/tmp/pip-A8TMvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26:24 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)) 04:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:24 INFO - Running setup.py (path:/tmp/pip-s7X5ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:25 INFO - Running setup.py (path:/tmp/pip-Ci8QQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26:25 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)) 04:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:25 INFO - Running setup.py (path:/tmp/pip-zFBFQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:25 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)) 04:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:25 INFO - Running setup.py (path:/tmp/pip-tH1Ecx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:25 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)) 04:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:25 INFO - Running setup.py (path:/tmp/pip-TtCJeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:25 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)) 04:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:25 INFO - Running setup.py (path:/tmp/pip-ofZFf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:25 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)) 04:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:25 INFO - Running setup.py (path:/tmp/pip-6JQiEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26:25 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)) 04:26:25 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)) 04:26:25 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)) 04:26:25 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)) 04:26:25 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)) 04:26:25 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)) 04:26:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:26:25 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 04:26:25 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 04:26:25 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 04:26:25 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 04:26:25 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 04:26:25 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 04:26:27 INFO - Downloading blessings-1.5.1.tar.gz 04:26:27 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 04:26:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:26:27 INFO - Installing collected packages: blessings 04:26:27 INFO - Running setup.py install for blessings 04:26:27 INFO - Successfully installed blessings 04:26:27 INFO - Cleaning up... 04:26:27 INFO - Return code: 0 04:26:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:26:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:27 INFO - Reading from file tmpfile_stdout 04:26:27 INFO - Current package versions: 04:26:27 INFO - argparse == 1.2.1 04:26:27 INFO - blessings == 1.5.1 04:26:27 INFO - blobuploader == 1.2.4 04:26:27 INFO - docopt == 0.6.1 04:26:27 INFO - manifestparser == 1.1 04:26:27 INFO - mozInstall == 1.12 04:26:27 INFO - mozcrash == 0.16 04:26:27 INFO - mozdebug == 0.1 04:26:27 INFO - mozdevice == 0.47 04:26:27 INFO - mozfile == 1.2 04:26:27 INFO - mozhttpd == 0.7 04:26:27 INFO - mozinfo == 0.9 04:26:27 INFO - mozleak == 0.1 04:26:27 INFO - mozlog == 3.1 04:26:27 INFO - moznetwork == 0.27 04:26:27 INFO - mozprocess == 0.22 04:26:27 INFO - mozprofile == 0.27 04:26:27 INFO - mozrunner == 6.11 04:26:27 INFO - mozscreenshot == 0.1 04:26:27 INFO - mozsystemmonitor == 0.0 04:26:27 INFO - moztest == 0.7 04:26:27 INFO - mozversion == 1.4 04:26:27 INFO - psutil == 3.1.1 04:26:27 INFO - requests == 1.2.3 04:26:27 INFO - wsgiref == 0.1.2 04:26:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:27 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')]} 04:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:27 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')]} 04:26:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:27 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 0x7f75a8dcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x161f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae0b0>, '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 0x16aefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16af440>, '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': 'd333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219', '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 04:26:27 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 04:26:27 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 04:26:27 INFO - Using env: {'DISPLAY': ':0', 04:26:27 INFO - 'HOME': '/home/cltbld', 04:26:27 INFO - 'LANG': 'en_US.UTF-8', 04:26:27 INFO - 'LANGUAGE': 'en_US:en', 04:26:27 INFO - 'LOGNAME': 'cltbld', 04:26:27 INFO - 'MAIL': '/var/mail/cltbld', 04:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:27 INFO - 'MOZ_NO_REMOTE': '1', 04:26:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:27 INFO - 'NO_EM_RESTART': '1', 04:26:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:27 INFO - 'PWD': '/builds/slave/test', 04:26:27 INFO - 'SHELL': '/bin/bash', 04:26:27 INFO - 'SHLVL': '1', 04:26:27 INFO - 'TERM': 'linux', 04:26:27 INFO - 'TMOUT': '86400', 04:26:27 INFO - 'USER': 'cltbld', 04:26:27 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219', 04:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:27 INFO - '_': '/tools/buildbot/bin/python'} 04:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:27 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)) 04:26:27 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)) 04:26:27 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)) 04:26:27 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)) 04:26:27 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)) 04:26:27 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)) 04:26:27 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)) 04:26:27 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)) 04:26:27 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)) 04:26:27 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)) 04:26:27 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)) 04:26:27 INFO - Cleaning up... 04:26:27 INFO - Return code: 0 04:26:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:26:27 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')]} 04:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:27 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')]} 04:26:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:27 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75a8dcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x161f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae0b0>, '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 0x16aefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16af440>, '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': 'd333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219', '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 04:26:27 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', 'jsonschema'] in /builds/slave/test/build 04:26:27 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 jsonschema 04:26:27 INFO - Using env: {'DISPLAY': ':0', 04:26:27 INFO - 'HOME': '/home/cltbld', 04:26:27 INFO - 'LANG': 'en_US.UTF-8', 04:26:27 INFO - 'LANGUAGE': 'en_US:en', 04:26:27 INFO - 'LOGNAME': 'cltbld', 04:26:27 INFO - 'MAIL': '/var/mail/cltbld', 04:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:27 INFO - 'MOZ_NO_REMOTE': '1', 04:26:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:27 INFO - 'NO_EM_RESTART': '1', 04:26:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:27 INFO - 'PWD': '/builds/slave/test', 04:26:27 INFO - 'SHELL': '/bin/bash', 04:26:27 INFO - 'SHLVL': '1', 04:26:27 INFO - 'TERM': 'linux', 04:26:27 INFO - 'TMOUT': '86400', 04:26:27 INFO - 'USER': 'cltbld', 04:26:27 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219', 04:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:27 INFO - '_': '/tools/buildbot/bin/python'} 04:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:28 INFO - Downloading/unpacking jsonschema 04:26:28 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 04:26:28 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 04:26:28 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 04:26:28 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 04:26:28 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 04:26:28 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 04:26:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:26:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:26:29 INFO - Downloading/unpacking functools32 (from jsonschema) 04:26:29 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 04:26:29 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 04:26:29 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 04:26:29 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 04:26:29 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 04:26:29 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 04:26:29 INFO - Downloading functools32-3.2.3-2.tar.gz 04:26:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:26:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:26:29 INFO - warning: no files found matching '*.txt' 04:26:29 INFO - no previously-included directories found matching 'build' 04:26:29 INFO - no previously-included directories found matching 'dist' 04:26:29 INFO - no previously-included directories found matching '.git*' 04:26:29 INFO - Installing collected packages: jsonschema, functools32 04:26:30 INFO - Running setup.py install for functools32 04:26:30 INFO - warning: no files found matching '*.txt' 04:26:30 INFO - no previously-included directories found matching 'build' 04:26:30 INFO - no previously-included directories found matching 'dist' 04:26:30 INFO - no previously-included directories found matching '.git*' 04:26:30 INFO - Successfully installed jsonschema functools32 04:26:30 INFO - Cleaning up... 04:26:30 INFO - Return code: 0 04:26:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:26:30 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')]} 04:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:30 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')]} 04:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:30 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75a8dcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x161f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae0b0>, '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 0x16aefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16af440>, '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': 'd333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219', '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 04:26:30 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', 'flake8'] in /builds/slave/test/build 04:26:30 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 flake8 04:26:30 INFO - Using env: {'DISPLAY': ':0', 04:26:30 INFO - 'HOME': '/home/cltbld', 04:26:30 INFO - 'LANG': 'en_US.UTF-8', 04:26:30 INFO - 'LANGUAGE': 'en_US:en', 04:26:30 INFO - 'LOGNAME': 'cltbld', 04:26:30 INFO - 'MAIL': '/var/mail/cltbld', 04:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:30 INFO - 'MOZ_NO_REMOTE': '1', 04:26:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:30 INFO - 'NO_EM_RESTART': '1', 04:26:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:30 INFO - 'PWD': '/builds/slave/test', 04:26:30 INFO - 'SHELL': '/bin/bash', 04:26:30 INFO - 'SHLVL': '1', 04:26:30 INFO - 'TERM': 'linux', 04:26:30 INFO - 'TMOUT': '86400', 04:26:30 INFO - 'USER': 'cltbld', 04:26:30 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219', 04:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:30 INFO - '_': '/tools/buildbot/bin/python'} 04:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:30 INFO - Downloading/unpacking flake8 04:26:30 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 04:26:30 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 04:26:30 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 04:26:30 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 04:26:30 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 04:26:30 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 04:26:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:26:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:26:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:26:32 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 04:26:32 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 04:26:32 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 04:26:32 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 04:26:32 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 04:26:32 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 04:26:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:26:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:26:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:26:32 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 04:26:32 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 04:26:32 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 04:26:32 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 04:26:32 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 04:26:32 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 04:26:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:26:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:26:32 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 04:26:32 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 04:26:32 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 04:26:32 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 04:26:32 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 04:26:32 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 04:26:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:26:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:26:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:26:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:26:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:26:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:26:32 INFO - no previously-included directories found matching 'docs/_build' 04:26:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:26:32 INFO - Running setup.py install for pep8 04:26:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:26:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:26:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:26:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:26:32 INFO - no previously-included directories found matching 'docs/_build' 04:26:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:26:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:26:32 INFO - Cleaning up... 04:26:32 INFO - Return code: 0 04:26:32 INFO - Running post-action listener: _resource_record_post_action 04:26:32 INFO - Running post-action listener: _start_resource_monitoring 04:26:33 INFO - Starting resource monitoring. 04:26:33 INFO - ##### 04:26:33 INFO - ##### Running install step. 04:26:33 INFO - ##### 04:26:33 INFO - Running pre-action listener: _resource_record_pre_action 04:26:33 INFO - Running main action method: install 04:26:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:33 INFO - Reading from file tmpfile_stdout 04:26:33 INFO - Detecting whether we're running mozinstall >=1.0... 04:26:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:26:33 INFO - Reading from file tmpfile_stdout 04:26:33 INFO - Output received: 04:26:33 INFO - Usage: mozinstall [options] installer 04:26:33 INFO - Options: 04:26:33 INFO - -h, --help show this help message and exit 04:26:33 INFO - -d DEST, --destination=DEST 04:26:33 INFO - Directory to install application into. [default: 04:26:33 INFO - "/builds/slave/test"] 04:26:33 INFO - --app=APP Application being installed. [default: firefox] 04:26:33 INFO - mkdir: /builds/slave/test/build/application 04:26:33 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'] 04:26:33 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 04:26:47 INFO - Reading from file tmpfile_stdout 04:26:47 INFO - Output received: 04:26:47 INFO - /builds/slave/test/build/application/firefox/firefox 04:26:47 INFO - Running post-action listener: _resource_record_post_action 04:26:47 INFO - ##### 04:26:47 INFO - ##### Running run-tests step. 04:26:47 INFO - ##### 04:26:47 INFO - Running pre-action listener: _resource_record_pre_action 04:26:47 INFO - Running main action method: run_tests 04:26:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:26:47 INFO - Python 2.7.3 04:26:47 INFO - Return code: 0 04:26:47 INFO - grabbing minidump binary from tooltool 04:26:47 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')]} 04:26:47 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 0x16ae0b0>, '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 0x16aefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16af440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:26:47 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 04:26:47 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 04:26:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:26:47 INFO - Return code: 0 04:26:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:26:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:26:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:26:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:26:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:26:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:26:48 INFO - Return code: 0 04:26:48 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/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost'] in /builds/slave/test/build 04:26:48 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/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost 04:26:48 INFO - Using env: {'DISPLAY': ':0', 04:26:48 INFO - 'HOME': '/home/cltbld', 04:26:48 INFO - 'LANG': 'en_US.UTF-8', 04:26:48 INFO - 'LANGUAGE': 'en_US:en', 04:26:48 INFO - 'LOGNAME': 'cltbld', 04:26:48 INFO - 'MAIL': '/var/mail/cltbld', 04:26:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:26:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:48 INFO - 'MOZ_NO_REMOTE': '1', 04:26:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:48 INFO - 'NO_EM_RESTART': '1', 04:26:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:48 INFO - 'PWD': '/builds/slave/test', 04:26:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:26:48 INFO - 'SHELL': '/bin/bash', 04:26:48 INFO - 'SHLVL': '1', 04:26:48 INFO - 'TERM': 'linux', 04:26:48 INFO - 'TMOUT': '86400', 04:26:48 INFO - 'USER': 'cltbld', 04:26:48 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219', 04:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:48 INFO - '_': '/tools/buildbot/bin/python'} 04:26:48 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/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost'] with output_timeout 3600 04:26:48 INFO - mozversion INFO | application_buildid: 20151127103731 04:26:48 INFO - mozversion INFO | application_changeset: f48352b311eb120a09347efce60ae9045401858c 04:26:48 INFO - mozversion INFO | application_display_name: Nightly 04:26:48 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:26:48 INFO - mozversion INFO | application_name: Firefox 04:26:48 INFO - mozversion INFO | application_remotingname: firefox 04:26:48 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:26:48 INFO - mozversion INFO | application_vendor: Mozilla 04:26:48 INFO - mozversion INFO | application_version: 45.0a1 04:26:48 INFO - mozversion INFO | platform_buildid: 20151127103731 04:26:48 INFO - mozversion INFO | platform_changeset: f48352b311eb120a09347efce60ae9045401858c 04:26:48 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:26:48 INFO - mozversion INFO | platform_version: 45.0a1 04:26:48 INFO - 2015-12-02 04:26:48,806 DEBUG : using testdate: 1449059208 04:26:48 INFO - 2015-12-02 04:26:48,807 DEBUG : actual date: 1449059208 04:26:48 INFO - 2015-12-02 04:26:48,816 INFO : starting webserver on 'localhost:51617' 04:26:48 INFO - 2015-12-02 04:26:48,817 INFO : Starting test suite talos-linux64-ix-051 04:26:48 INFO - 2015-12-02 04:26:48,817 INFO : Starting test dromaeo_css 04:26:48 INFO - 2015-12-02 04:26:48,817 DEBUG : operating with platform_type : linux_ 04:26:48 INFO - 2015-12-02 04:26:48,818 INFO : Initialising browser for dromaeo_css test... 04:26:48 INFO - 2015-12-02 04:26:48,825 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKSyumJ/profile http://localhost:51617/getInfo.html 04:26:52 INFO - 2015-12-02 04:26:52,821 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:26:52 INFO - 2015-12-02 04:26:52,821 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:26:52 INFO - 2015-12-02 04:26:52,821 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:26:52 INFO - 2015-12-02 04:26:52,821 DEBUG : BROWSER_OUTPUT: __metrics 04:26:52 INFO - 2015-12-02 04:26:52,970 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:26:54 INFO - 2015-12-02 04:26:54,143 INFO : Browser initialized. 04:26:54 INFO - 2015-12-02 04:26:54,144 INFO : Running cycle 1/1 for dromaeo_css test... 04:26:54 INFO - 2015-12-02 04:26:54,144 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKSyumJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:27:05 INFO - 2015-12-02 04:27:05,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 138801152 04:27:05 INFO - 2015-12-02 04:27:05,955 DEBUG : BROWSER_OUTPUT: 04:27:57 INFO - 2015-12-02 04:27:57,178 DEBUG : BROWSER_OUTPUT: 1449059277171 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] 04:30:08 INFO - 2015-12-02 04:30:08,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51617/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51617/tests/dromaeo/cssquery-ext.html) 04:30:10 INFO - 2015-12-02 04:30:10,023 DEBUG : BROWSER_OUTPUT: RSS: Main: 245686272 04:30:10 INFO - 2015-12-02 04:30:10,024 DEBUG : BROWSER_OUTPUT: 04:33:12 INFO - 2015-12-02 04:33:12,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51617/tests/dromaeo/cssquery-ext.html (next: http://localhost:51617/tests/dromaeo/cssquery-jquery.html) 04:33:13 INFO - 2015-12-02 04:33:13,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 220295168 04:33:13 INFO - 2015-12-02 04:33:13,121 DEBUG : BROWSER_OUTPUT: 04:36:15 INFO - 2015-12-02 04:36:15,113 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51617/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51617/tests/dromaeo/cssquery-mootools.html) 04:36:15 INFO - 2015-12-02 04:36:15,694 DEBUG : BROWSER_OUTPUT: RSS: Main: 214683648 04:36:15 INFO - 2015-12-02 04:36:15,694 DEBUG : BROWSER_OUTPUT: 04:39:17 INFO - 2015-12-02 04:39:17,733 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51617/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51617/tests/dromaeo/cssquery-prototype.html) 04:39:18 INFO - 2015-12-02 04:39:18,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 201498624 04:39:18 INFO - 2015-12-02 04:39:18,314 DEBUG : BROWSER_OUTPUT: 04:42:21 INFO - 2015-12-02 04:42:21,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51617/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51617/tests/dromaeo/cssquery-yui.html) 04:42:21 INFO - 2015-12-02 04:42:21,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 205627392 04:42:21 INFO - 2015-12-02 04:42:21,695 DEBUG : BROWSER_OUTPUT: 04:45:24 INFO - 2015-12-02 04:45:24,086 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51617/tests/dromaeo/cssquery-yui.html (next: http://localhost:51617/tests/dromaeo/cssquery-dojo.html) 04:45:24 INFO - 2015-12-02 04:45:24,344 DEBUG : BROWSER_OUTPUT: RSS: Main: 252825600 04:45:24 INFO - 2015-12-02 04:45:24,344 DEBUG : BROWSER_OUTPUT: 04:45:24 INFO - 2015-12-02 04:45:24,344 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:45:24 INFO - 2015-12-02 04:45:24,344 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:45:24 INFO - 2015-12-02 04:45:24,344 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:45:24 INFO - 2015-12-02 04:45:24,344 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:45:24 INFO - 2015-12-02 04:45:24,344 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2599.415131595391;2690.816040941985;2701.6487856578665;2707.7021527631955;2722.278596172014;4432.445944256968;4546.3180522921575;4607.470140933798;4619.514950930155;4634.351190833286;4511.90976180477;4543.204939135655;4584.793684284207;4596.264597664366;4621.884452888671;4265.957340426595;4306.289462238727;4307.569243075683;4326.7187632803925;4346;4102.487189101363;4333.739975601474;4364.978175109136;4388.802503887333;4394.648428125743;4202.978985105055;4263.445752052245;4271.444712187426;4290.442242508485;4315.4821421429315;4268.103698223377;4269.274223382033;4275.615194632498;4310.52584215736;4313.41768861206;4092.7339722918214;4242.957570424287;4269.124829409963;4273.059926816127;4290.077633308822;4432.889177770549;4502.684812063157;4515.4129963104915;4520.457545094577;4554.658400619966;4976.4277108132665;4982.850514484571;4993.375828021497;4995.525425084611;5061.240813877911;4885.804567817283;5014.24786282057;5020.497950204986;5026.874328141789;5028.270900719375;4577.656675749332;4633.003904160588;4638.698484598558;4647.767611619439;4707.152712511781;5146.382434107856;5151.613628977767;5157.484251574888;5168.948310516922;5196.9740151299;4754.78603462845;4929.531694489017;4961.305417241589;4964;5020.347354843847;4976.4525902150735;4976.527229913152;4982.103221420107;5074.847754567369;5092.821751238689;4974.751262436864;4976.328195693607;4983.476734942851;4991.226359914219;5046;4705.247160454311;4945.23348880924;4945.802167913315;4951.752412379438;4998.90002199954;4123.628873401348;4182.811773470201;4186.455760751144;4205.873823785291;4245.27830268855;3722.7952462614817;3726.925461490755;3733.4026555751493;3746.3256613809776;3753.3806921857586;4169.395437661522;4337.067530480962;4337.609615134653;4374.409454723572;4380.6057454829215;4930.433000204951;4930.926036109461;4956.776945037482;4963.057019166346;4990.201567749215;4231.407602935591;4279.850205242801;4287.721298115613;4296.462942132233;4342.609165175149;4445.799939002753;4455.68810183284;4467.865964021084;4490.730556166641;4509.413776209072;4570.314452832102;4685.6017238535105;4685.625149987993;4688.484266730725;4779.761011949458;4993.300937868774;5019.498050194951;5020.171671674133;5020.648554601143;5060.291559181791;4757.09615173116;4758.738269395078;4760.047990401864;4763.261694437368;4800;4694.3427920090535;4707.152712511781;4710.929336059893;4763.809447622057;4768.189407800752;4807.278908163664;4848.515148485123;4887.218045112765;4892.68197567157;4930.457649658463;4816.783244753924;4842.055799119138;4877.804887804448;4880.31675565414;4921.63087768426;4695.22528782747;4844.757762111951;4882.877928051827;4886.242632391843;4914.434839993446;4667.416572928384;4746.33551302811;4757.809687612456;4760.833370832004;4786.521347865186;4878.195097808822;4906.975465122794;4912.778924948315;4914.385701787277;4921.630877684116;4795.976020119877;4820.39745031871;4823.27650852375;4824.107540105092;4869.853904382874 04:45:24 INFO - 2015-12-02 04:45:24,345 DEBUG : BROWSER_OUTPUT: |1;ext.html;535.0689799748437;551.3934671860952;552.138663684652;565.183310116881;570.9371969083397;28522.14433566994;29084.127476175723;37902.810485947564;38149.42775858357;38189.427158592574;40137.19725605486;40641.187176256455;40648.79675601625;40709.18581628366;40810.38784418236;7051.823704407379;7763.961180194091;7918.524888506708;7922.841543169133;7926.326262267714;6960.860782784342;7026.754063607775;7037.788866334018;7039.436845052409;10125.797484050314;9974.551145198484;10165.135963443116;10172.847407288897;10194.439305838176;10197.541110650001;10032.347897386682;10196.541155648014;10197.796044079114;10198.490075496196;10208.948955255251;7219.35025847671;7403.888941665879;10189.847152292721;10455.215858810543;10458.477076146239;37766;37882;37966.43050354247;38290.61709382899;38311.808440957895;2809.9297517562222;2870;2877.568364745284;2890.682024977251;2913.941721165586;28647;28891.133266002053;29058.854705726546;29110.854445727637;29554.556681649792;3439.4496880499;3466.098814308298;3498.422760244582;3510.824458777051;3602.765820221677;216870;217826;218337;218543;218736;51332.74333628383;55549.444505555235;55856.441435585126;55900.44099559034;55970.72014639982;42534.787326063175;59187.40812591905;60400.093998590055;60404.09393859096;60524;12109.515619375126;12404.937975310066;12521;12531.624051278477;12536.874631253753;8571.100034496412;8634.222919937236;8652.913470865336;8660.956695216484;8690.04409514953;19081.522961926064;19145.329913452963;19255.8074419254;19392.8060719391;19399.515012124528;7096.432285417154;7395.482316237919;7432.479726419098;7477.214892436325;7507.286807753255;815.5759005317202;851.2338894994431;866.7616405488415;880.3573391424168;882.7440042387635;24446;24673.383165421008;24795.87602061978;24820.131295404575;24838.627420588706;967.3422072990294;1003.3879333606494;1055.1084333737979;1061.5965932945585;1074.5648012554927;12242.571509997286;12751.107422480338;12853.871461285455;12859.0998630095;12910.483580656857;266484;270179;270443;271399;271832;45296.3205551917;45344.3198352025;45368.31947520724;45407.772961134986;45695.54304456913;1154.1920655541155;1157.0280963990288;1186.8160435132568;1191.880811918801;1194.3013337197663;21720.565588688452;23883.402914927265;25956.35109122287;26283.737162628895;29014.27464313409;39103;39373;39377.60622393854;39384.40923386094;39465.40801888031;176465;176984;177638;178058;230340;22839;28964;29159.416811664072;29577.408451831274;29691;32314;38641;38818;39806.203875922896;39986.60013399829;31644.683553165094;31834.36331273408;32236.516452253705;32659.510107347935;32902.506462402605;32318.67681323251;32936.176595585304;33056.66943330536;34500.82749586236;37318.62681373151;29946.850265748533;30022.399552009276;30029.249268768457;30037.69962300349;30609;28054.85972570124;29023.564646529896;29702.327115366323;30152;31625.8418707905;23047.423814404774;23490.530189395773;23497.41256468602;25128.62307065359;25130.874345628155 04:45:24 INFO - 2015-12-02 04:45:24,345 DEBUG : BROWSER_OUTPUT: |2;jquery.html;316.6263808705728;319.88164379179705;323.936832317698;325.9136328872849;326.2284696692322;12440.81338779919;12832.139339795724;14741.926290368547;15134.848651513495;15354.385824567018;11606.187566870323;13349.59951201463;13862.792058119136;14411.855881441208;14468.059576127544;3903.687704983609;4934.851954441364;5009.298698182258;5033.119204139261;5070.112730272206;4963.975180124113;4971.105201063807;4997.625178111638;5004.524570165829;5012.598992080643;4919.680220785637;4962.727050012248;4997;5073.441921388644;5073.974630126844;5015.172496538067;5018.34761481007;5022.397312322526;5024.447310795809;5024.82413115541;4437.090396468716;4444.644428445717;4447.08834688888;4454.086912183027;4455.866324010285;19762.11070501831;19928.80071199284;20525;21198.258060967946;21337;1937.5737337785665;2010.6380851446734;2032.7967203279702;2046.1201683276186;2062.0720675695998;13453.469634153038;13547.119437236646;13689.726205475834;14037.087589306764;14238.715225695429;1771.070188151231;1802.7476153338544;1919.5968846542244;1923.0480911948675;1930.94207173785;58083.41916580822;58191.616766467065;58704.41295587032;60229;64151.358486415;15424.614384640474;15453.845461545465;15473.767893481607;15479;15586.90891637597;18590.721139182922;19140.90429547871;20619.381418557467;23709.7629023711;23778.762212378002;7756.806079847936;7836.686532538634;7899.68401263943;7931.286184243446;7953.602319883983;6551.8362040948405;6568.1789776277965;6607.174103237096;6624.403803657694;6644.900326495106;7385.519941203805;7480.663370148356;7505.924940750632;7526.736564220226;7635.988990478607;2885.6825749167574;2943.823370597771;2972.331225474251;2974.6430428348303;3101.9224519387194;781.2655903893348;837.3092198935902;888.8266787976282;919.852823548229;988.3427520698655;15168.165750883807;15416.614584635474;15507.302171402314;15649.765253521206;15768.76346854798;787.5668382389778;810.4165001199127;834.4784509681449;876.1632640827994;948.137195152408;7173.92826071743;8476.449030812977;8677.739667809976;8742.08208138149;8823.735287941372;485054;489680;490707;497442;498270;49730.95579426964;69371.3062869375;69591.65204174048;70076;70920.64539677268;981.8870829854516;1003.4079892863246;1004.2267454060333;1020.1838529176629;1021.7598864266891;8741.694040708544;8881.955590222007;14539.41842326295;14561.126332420088;14781.630459238606;31804.522932155574;32738.1815454606;33140.502892457116;33588.49617255792;33916.660833392336;41434.79282603568;43538.564614353454;43540.34689479597;43673;47909;13571.59285221445;13757.17456952546;14265.072770269899;14271.500497482539;14302.642433939234;17259.568510787332;17268.65462690714;17328.39350622722;17371.7394239084;17681.115944202997;13613.209292095295;13867.930660347038;14184.290785460893;14306;14647.194404307866;14143.717125657635;14313.928430357782;14348.426062957366;14734.115953042852;15179.696406071596;14186.148831070168;14272.072315299472;14343.354549045109;15013.324400402227;15350.692986140439;13436.798448023483;13575.25336106484;13585.864141358856;13709.383077761724;13750.312484375941;7806.609669516615;8133.7966550834335;8135.064467586303;14971.101733895566;15124.319405626993 04:45:24 INFO - 2015-12-02 04:45:24,345 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1400.2018849255928;1548.45803968611;1598.0252046251785;1619.7570364445335;1630.6331075508006;5641.097424412095;6431.742730290789;6606.8678626427445;6655.567388119769;6664.500162487809;6487.610743355402;6629.834254143649;6635.568688035274;6635.966820165904;6639.966800166005;1642.6468309313495;1671.8996860188367;1674.5646132005704;1913.674675305198;1940.4372731907729;1924.509250141212;1955.1104247567323;1966.1840336260434;1968.5767559974602;1970;1879.6146789908037;1896;1908.9045547722628;1930.9227630894748;1931.449536881989;1952.2093552111346;1972.960540789176;1975.170428420067;1975.387629834756;1977.772556156046;1937.2347922570646;1972.9704054439194;1975.4666240115232;1978.9505262368411;1979.712941623471;6541.47668186544;6589.275179730226;6592.1100651411925;6593.307702691196;6596.175478065242;3561.1097225693575;3616.367135751233;3639.890803275906;3642.6175251598465;3645.9453108203397;2481.1440053181623;2547.235829251236;2553.9489210215693;2566.396896729267;2595.3122422558035;765.4450523370567;835.4569529805614;853.1212850763724;897.0356866368679;947.9193719160163;8633.913660863374;8644.22202001823;8673.826523469495;8678.826423471559;8681.30549556034;3464.6188919218866;3498.5976612689356;3549.2369140634887;3562.786232826039;3565.8038807865814;7532.661030253652;7541.660625271876;7546.056742907137;7564.546127232384;7565.6217189140325;3720.162963333228;3728.179800443898;3753.136778540896;3759.3045286622064;3788.791616461066;3386.779859309137;3389.7288216942584;3391.372596069735;3395.8471868765964;3413.914652133667;2846.075025616683;2905.0994191800187;3134.561161437355;3140.0893740815363;3189.6172459304566;938.2072149034055;965.9227261819037;966.8839739231337;967.8693376394097;970.815545046439;920.5765347939889;920.8296465153834;951.2104952889224;1087.5323610847254;1176.2883455509464;6240.719167637377;6259.530535209787;6267.4986001119805;6289.905651415233;6310.274318453345;980.568549838069;984.7981163861391;1012.9088382045651;1013.6097602423121;1014.5637375928421;5062.088824011713;5110;5119.48805119485;5121.897562048738;5122.052420302181;7640.770776876702;7743.264389883065;7881.921180788233;7882.093559240646;7983.8403231935035;7861.213878612093;7866.213378662088;7878.960605196938;7889.605519723991;7928.682852685828;6111.663858487737;6163.3836616338;6187.783427580103;6223.37766223374;6229.377062293825;5909.645421274738;6019.72911219005;6081.817545473643;6095.908561371494;6100.786472473442;7004.579725216503;7051.823704407431;7102;7134.1795693495915;7215.458840586872;7162.928370716226;7252;7360.484766066324;7360.66876990526;7376.815579610553;5640.971795140998;5676.914846277226;5707.457791509966;5707.714614269353;5711.428857114255;5327.280817089643;5476.479734425223;6410.775622853178;6449.290578036506;6460.644664543495;5599.468050535193;5835.7373918174635;5841.970790146022;5975.850603734942;5999.280086389661;5800.854978625568;5878.3239927407185;5879.059350503899;5915.645061296336;6029.788957386646;5765;6055.788047418319;6057.242844644419;6062.696865156637;6063.787767428119;5438.10271305246;5495.587830912617;5507.504324610804;5635.098384258663;5642.858928526655;5457.372402173642;5458.836234912959;5468.890622187454;5481.068218402961;5485.341758988788 04:45:24 INFO - 2015-12-02 04:45:24,346 DEBUG : BROWSER_OUTPUT: |4;prototype.html;268.6239265028959;275.0212223055118;276.48711639907964;287.00266573656535;287.50979579816413;5187.092258854705;5236.764345604447;5310.336207974004;5333.519983201511;5341.4124446310925;5093.9235911461265;5219.191025391061;5225.268462415255;5242.606804489659;5253.185756207784;4110.219058378913;4111.239420707178;4112.992316882368;4114.444549985758;4124.113315637137;3837.9232415351676;3943.2902077626018;3994.920101597966;4112.259793237216;4113.979430102845;4045.2111838191563;4046.898827529306;4072.36878283865;4075.286824805662;4077.612626800449;4058.0463591056227;4061.1065565575673;4065.1666408386504;4070.005697208376;4072.490938632671;3553.129483276614;3555.484454754046;3556.697680697144;3562;3564.322778672044;4976.751162441863;5084.3644544431945;5085.974570127126;5086.059079070347;5089.440161582223;4648.651351148644;4652.209124448852;4655.51117132703;4657.138429390539;4657.930131048037;5494.835154945358;5516.282883225195;5530.778768849241;5531.115021596565;5531.640443371168;3584.605693373727;3675.5038069860493;3737.5328083989502;3848.8845334640005;3853.460515527828;5767.1637612546365;5778.306603207642;5784.710764461718;5793.710314484259;5800.738966746507;3965.464662270614;3965.5439624442984;3965.6629186518894;3975.582563830814;3978.701597380208;4036.858709945138;4037.596240375939;4040.313146765057;4044.9595504044582;4049.271131196354;4445.466544014739;4517.796699148546;4617.953820461819;4624.445066591963;4625.7455839929125;5424.755885985141;5451.945480545223;5459.071957767189;5463.617546771768;5466.426025267369;1417.0364152376276;1417.206364435919;1417.8511256318145;1418.4680744720729;1418.900676952624;946.8295706772709;973.3089506450358;977.4233202410612;990.9405435673883;996.2478328861808;4848.80604775805;4849.684770489906;4854.441739200037;4857.611391088704;4861.781219845116;5716.1997320375185;5732.082866741302;5733.88532229353;5746.2529871116485;5758.798442054508;4846.75766211688;4859.538343857399;4862.7325497098;4863.1732605457155;4870.391201099863;2905.86418982048;3014.427258820817;3067.98466007673;3091.5053591425262;3103.90688279352;4465.977670111629;5370.838874833761;5409.756560954766;5432.429594892558;5497.147942068986;5932.644041357532;5935.643861368331;5943.108533719977;5948.434898684618;5971.19388882504;5456.90861827636;5462.672239665632;5467.480589344006;5467.808626698046;5473.67157970523;5776.075827867521;5791.218185544897;5795.420457954171;5796.971015144897;5803.883922321615;5425.376081750649;5578.748956296895;5663.830085097454;5665.518430933417;5677.5457963362005;5383;5494.148406996922;5500;5506.779728810803;5511.586631002771;3993.4608827807874;3997.360422332413;4000.1999600079516;4005.2990726622143;4006.59934006597;5757.79847705345;5775.133729940375;5782.190493330853;5792.768289268382;5806.129080637938;5388.057090009311;5515.751791169327;5589.636673616202;5595.916061259166;5602.075657516464;5552.305961754781;5571.4428557143965;5589.80435684749;5600.215969764155;5605.831825045255;5479.780808767764;5489.780408783604;5496.450354964471;5499.642523235977;5505.532029777513;5514.338279406336;5615.550755939434;5621.381648018796;5635.915461268166;5650.915236271541;5500.339959204921;5503.477169668875;5508.0911649578975;5508.788066625336;5511.751971161227 04:45:24 INFO - 2015-12-02 04:45:24,346 DEBUG : BROWSER_OUTPUT: |5;yui.html;571.5113577890903;604.812508122482;637.6461064109418;679.6296018669824;690.078744875591;10371.636992705256;10525.421101839396;10526.789464210711;10532.789344213112;10587.470626468674;10137.594496220161;11281.774364512725;11434.313941163537;11491.885081149187;11545.769084618303;601.5909181756404;607.1196764691193;754.1892465599475;768.3814529303908;769.2192424688945;608.0696534302502;758.4993904023346;774.3727580659655;774.4385320642546;775.5385545600359;795.8607243732353;804.1476035402463;808.5714571277204;809.2312303311847;809.3080416244114;633.8415396150963;640.5036097024796;776.7747353267546;794.2772077409529;799.8800179973022;584.6696616411756;585.4701495146899;585.935547089824;586.1734953715242;586.2349633727983;10242.180625549938;10377.325473844176;10380.896191038068;10393.22050846182;10393.636222732168;10699.572017119384;10945.343279403261;10964.013238808546;11294.887051129466;12137.393130343537;9166.633334666605;9240.722778316662;9504.572294246775;9739.41563506192;9774.12032917041;3168.8732450701946;3187.15540381799;3199.504076868089;3221.8066915985114;3263.9836800816083;41862.16275674469;41871.58128418707;42033.1593368134;42180;42379.57620423818;8742.169493898069;8919.821603568022;8977.416467929694;9002.86495702565;9195.586198621078;16310;16421.261043253082;16528.66942661164;16560.585985350463;16584.83415165857;6554.680490479571;6577;6595.8021259362295;6647.202335719745;6677.198736151693;3625.5830579483168;3660.5607327120915;3707.7404581679025;3711.1278849470355;3754.4743735877;2569.6659434273424;2621.7902567794913;2624.2258533732593;2635.222609330252;2647.4440367523034;494.7946602160063;498.35960790384183;500.9223570346602;504.009621094551;506.21283903530366;455.5694868349444;531.6730210920333;569.5728203847115;579.7999690106991;588.3812075209571;7071.681774320065;7124.8575028499135;7538.509996850187;7646.273604007611;7835.373170146375;462.3111563769959;571.4885177765876;581.2734082397004;591.7928724946235;597.6623207887617;3413.8975830725117;3494.685478306965;3524.665156810099;3572.4284114541547;3609.097725568608;54248.728756355966;54497.72751136219;54911;54930.72534637381;55001.72499137559;46764.29853552199;47313.763431182626;47408.76295618569;47415.762921185866;47418.28872566914;41803.163936721096;42723.35914961278;42998.14003719908;43180;43302.35046474305;7187.604681742554;7217.891731624135;7313.890291645736;7320.304571065741;7331.450141239535;31460.842695786374;31813.68186318107;31937.68062319347;32022.359552808346;32624.510632341007;38786;38801.6119838798;40898.79550602228;41496.377554336104;41890.37164442475;8408.285295749929;8830.955845220733;8984.281257499253;9026.45841249527;9043.278475638846;9606.231501480004;9721.805563888824;9996.800063998824;10156.39061656303;10156.542955567165;9083;9121.863172052292;9396.953015235154;9605.37565058269;9687.612495500101;9407.85888211691;9424.575894084646;9477.573509191965;9712.757181070247;9733.9026609733;8895.110488951053;9092.772680683036;9115;9143.405678630868;9743;7993.920060799318;8246.793830154294;8336.249737523653;8379.49723016621;8468.237858592756;8060.596970151351;8646.221840034426;8656.22094011542;8709.303255739398;8996.235319997873 04:45:24 INFO - 2015-12-02 04:45:24,346 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:45:24 INFO - 2015-12-02 04:45:24,346 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:45:24 INFO - 2015-12-02 04:45:24,346 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,897 04:45:24 INFO - 2015-12-02 04:45:24,346 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:45:24 INFO - 2015-12-02 04:45:24,346 DEBUG : BROWSER_OUTPUT: __startTimestamp1449060324338__endTimestamp 04:45:24 INFO - 2015-12-02 04:45:24,346 DEBUG : BROWSER_OUTPUT: 04:45:24 INFO - 2015-12-02 04:45:24,346 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:45:24 INFO - 2015-12-02 04:45:24,347 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:45:24 INFO - 2015-12-02 04:45:24,347 DEBUG : BROWSER_OUTPUT: 04:45:24 INFO - 2015-12-02 04:45:24,347 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4594.67 Median:4707.15 stddev:471.06 (10.0%) stddev-sans-first:445.74 04:45:24 INFO - 2015-12-02 04:45:24,348 DEBUG : BROWSER_OUTPUT: Values: 2599.4 2690.8 2701.6 2707.7 2722.3 4432.4 4546.3 4607.5 4619.5 4634.4 4511.9 4543.2 4584.8 4596.3 4621.9 4266.0 4306.3 4307.6 4326.7 4346.0 4102.5 4333.7 4365.0 4388.8 4394.6 4203.0 4263.4 4271.4 4290.4 4315.5 4268.1 4269.3 4275.6 4310.5 4313.4 4092.7 4243.0 4269.1 4273.1 4290.1 4432.9 4502.7 4515.4 4520.5 4554.7 4976.4 4982.9 4993.4 4995.5 5061.2 4885.8 5014.2 5020.5 5026.9 5028.3 4577.7 4633.0 4638.7 4647.8 4707.2 5146.4 5151.6 5157.5 5168.9 5197.0 4754.8 4929.5 4961.3 4964.0 5020.3 4976.5 4976.5 4982.1 5074.8 5092.8 4974.8 4976.3 4983.5 4991.2 5046.0 4705.2 4945.2 4945.8 4951.8 4998.9 4123.6 4182.8 4186.5 4205.9 4245.3 3722.8 3726.9 3733.4 3746.3 3753.4 4169.4 4337.1 4337.6 4374.4 4380.6 4930.4 4930.9 4956.8 4963.1 4990.2 4231.4 4279.9 4287.7 4296.5 4342.6 4445.8 4455.7 4467.9 4490.7 4509.4 4570.3 4685.6 4685.6 4688.5 4779.8 4993.3 5019.5 5020.2 5020.6 5060.3 4757.1 4758.7 4760.0 4763.3 4800.0 4694.3 4707.2 4710.9 4763.8 4768.2 4807.3 4848.5 4887.2 4892.7 4930.5 4816.8 4842.1 4877.8 4880.3 4921.6 4695.2 4844.8 4882.9 4886.2 4914.4 4667.4 4746.3 4757.8 4760.8 4786.5 4878.2 4907.0 4912.8 4914.4 4921.6 4796.0 4820.4 4823.3 4824.1 4869.9 04:45:24 INFO - 2015-12-02 04:45:24,348 DEBUG : BROWSER_OUTPUT: 04:45:24 INFO - 2015-12-02 04:45:24,348 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38773.17 Median:30094.85 stddev:59438.11 (197.5%) stddev-sans-first:59535.50 04:45:24 INFO - 2015-12-02 04:45:24,348 DEBUG : BROWSER_OUTPUT: Values: 535.1 551.4 552.1 565.2 570.9 28522.1 29084.1 37902.8 38149.4 38189.4 40137.2 40641.2 40648.8 40709.2 40810.4 7051.8 7764.0 7918.5 7922.8 7926.3 6960.9 7026.8 7037.8 7039.4 10125.8 9974.6 10165.1 10172.8 10194.4 10197.5 10032.3 10196.5 10197.8 10198.5 10208.9 7219.4 7403.9 10189.8 10455.2 10458.5 37766.0 37882.0 37966.4 38290.6 38311.8 2809.9 2870.0 2877.6 2890.7 2913.9 28647.0 28891.1 29058.9 29110.9 29554.6 3439.4 3466.1 3498.4 3510.8 3602.8 216870.0 217826.0 218337.0 218543.0 218736.0 51332.7 55549.4 55856.4 55900.4 55970.7 42534.8 59187.4 60400.1 60404.1 60524.0 12109.5 12404.9 12521.0 12531.6 12536.9 8571.1 8634.2 8652.9 8661.0 8690.0 19081.5 19145.3 19255.8 19392.8 19399.5 7096.4 7395.5 7432.5 7477.2 7507.3 815.6 851.2 866.8 880.4 882.7 24446.0 24673.4 24795.9 24820.1 24838.6 967.3 1003.4 1055.1 1061.6 1074.6 12242.6 12751.1 12853.9 12859.1 12910.5 266484.0 270179.0 270443.0 271399.0 271832.0 45296.3 45344.3 45368.3 45407.8 45695.5 1154.2 1157.0 1186.8 1191.9 1194.3 21720.6 23883.4 25956.4 26283.7 29014.3 39103.0 39373.0 39377.6 39384.4 39465.4 176465.0 176984.0 177638.0 178058.0 230340.0 22839.0 28964.0 29159.4 29577.4 29691.0 32314.0 38641.0 38818.0 39806.2 39986.6 31644.7 31834.4 32236.5 32659.5 32902.5 32318.7 32936.2 33056.7 34500.8 37318.6 29946.9 30022.4 30029.2 30037.7 30609.0 28054.9 29023.6 29702.3 30152.0 31625.8 23047.4 23490.5 23497.4 25128.6 25130.9 04:45:24 INFO - 2015-12-02 04:45:24,348 DEBUG : BROWSER_OUTPUT: 04:45:24 INFO - 2015-12-02 04:45:24,348 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27367.77 Median:16062.20 stddev:80203.83 (499.3%) stddev-sans-first:80403.11 04:45:24 INFO - 2015-12-02 04:45:24,349 DEBUG : BROWSER_OUTPUT: Values: 316.6 319.9 323.9 325.9 326.2 12440.8 12832.1 14741.9 15134.8 15354.4 11606.2 13349.6 13862.8 14411.9 14468.1 3903.7 4934.9 5009.3 5033.1 5070.1 4964.0 4971.1 4997.6 5004.5 5012.6 4919.7 4962.7 4997.0 5073.4 5074.0 5015.2 5018.3 5022.4 5024.4 5024.8 4437.1 4444.6 4447.1 4454.1 4455.9 19762.1 19928.8 20525.0 21198.3 21337.0 1937.6 2010.6 2032.8 2046.1 2062.1 13453.5 13547.1 13689.7 14037.1 14238.7 1771.1 1802.7 1919.6 1923.0 1930.9 58083.4 58191.6 58704.4 60229.0 64151.4 15424.6 15453.8 15473.8 15479.0 15586.9 18590.7 19140.9 20619.4 23709.8 23778.8 7756.8 7836.7 7899.7 7931.3 7953.6 6551.8 6568.2 6607.2 6624.4 6644.9 7385.5 7480.7 7505.9 7526.7 7636.0 2885.7 2943.8 2972.3 2974.6 3101.9 781.3 837.3 888.8 919.9 988.3 15168.2 15416.6 15507.3 15649.8 15768.8 787.6 810.4 834.5 876.2 948.1 7173.9 8476.4 8677.7 8742.1 8823.7 485054.0 489680.0 490707.0 497442.0 498270.0 49731.0 69371.3 69591.7 70076.0 70920.6 981.9 1003.4 1004.2 1020.2 1021.8 8741.7 8882.0 14539.4 14561.1 14781.6 31804.5 32738.2 33140.5 33588.5 33916.7 41434.8 43538.6 43540.3 43673.0 47909.0 13571.6 13757.2 14265.1 14271.5 14302.6 17259.6 17268.7 17328.4 17371.7 17681.1 13613.2 13867.9 14184.3 14306.0 14647.2 14143.7 14313.9 14348.4 14734.1 15179.7 14186.1 14272.1 14343.4 15013.3 15350.7 13436.8 13575.3 13585.9 13709.4 13750.3 7806.6 8133.8 8135.1 14971.1 15124.3 04:45:24 INFO - 2015-12-02 04:45:24,349 DEBUG : BROWSER_OUTPUT: 04:45:24 INFO - 2015-12-02 04:45:24,349 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4579.35 Median:5818.30 stddev:2356.04 (40.5%) stddev-sans-first:2350.54 04:45:24 INFO - 2015-12-02 04:45:24,350 DEBUG : BROWSER_OUTPUT: Values: 1400.2 1548.5 1598.0 1619.8 1630.6 5641.1 6431.7 6606.9 6655.6 6664.5 6487.6 6629.8 6635.6 6636.0 6640.0 1642.6 1671.9 1674.6 1913.7 1940.4 1924.5 1955.1 1966.2 1968.6 1970.0 1879.6 1896.0 1908.9 1930.9 1931.4 1952.2 1973.0 1975.2 1975.4 1977.8 1937.2 1973.0 1975.5 1979.0 1979.7 6541.5 6589.3 6592.1 6593.3 6596.2 3561.1 3616.4 3639.9 3642.6 3645.9 2481.1 2547.2 2553.9 2566.4 2595.3 765.4 835.5 853.1 897.0 947.9 8633.9 8644.2 8673.8 8678.8 8681.3 3464.6 3498.6 3549.2 3562.8 3565.8 7532.7 7541.7 7546.1 7564.5 7565.6 3720.2 3728.2 3753.1 3759.3 3788.8 3386.8 3389.7 3391.4 3395.8 3413.9 2846.1 2905.1 3134.6 3140.1 3189.6 938.2 965.9 966.9 967.9 970.8 920.6 920.8 951.2 1087.5 1176.3 6240.7 6259.5 6267.5 6289.9 6310.3 980.6 984.8 1012.9 1013.6 1014.6 5062.1 5110.0 5119.5 5121.9 5122.1 7640.8 7743.3 7881.9 7882.1 7983.8 7861.2 7866.2 7879.0 7889.6 7928.7 6111.7 6163.4 6187.8 6223.4 6229.4 5909.6 6019.7 6081.8 6095.9 6100.8 7004.6 7051.8 7102.0 7134.2 7215.5 7162.9 7252.0 7360.5 7360.7 7376.8 5641.0 5676.9 5707.5 5707.7 5711.4 5327.3 5476.5 6410.8 6449.3 6460.6 5599.5 5835.7 5842.0 5975.9 5999.3 5800.9 5878.3 5879.1 5915.6 6029.8 5765.0 6055.8 6057.2 6062.7 6063.8 5438.1 5495.6 5507.5 5635.1 5642.9 5457.4 5458.8 5468.9 5481.1 5485.3 04:45:24 INFO - 2015-12-02 04:45:24,350 DEBUG : BROWSER_OUTPUT: 04:45:24 INFO - 2015-12-02 04:45:24,350 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4591.25 Median:5239.69 stddev:1359.31 (25.9%) stddev-sans-first:1323.83 04:45:24 INFO - 2015-12-02 04:45:24,350 DEBUG : BROWSER_OUTPUT: Values: 268.6 275.0 276.5 287.0 287.5 5187.1 5236.8 5310.3 5333.5 5341.4 5093.9 5219.2 5225.3 5242.6 5253.2 4110.2 4111.2 4113.0 4114.4 4124.1 3837.9 3943.3 3994.9 4112.3 4114.0 4045.2 4046.9 4072.4 4075.3 4077.6 4058.0 4061.1 4065.2 4070.0 4072.5 3553.1 3555.5 3556.7 3562.0 3564.3 4976.8 5084.4 5086.0 5086.1 5089.4 4648.7 4652.2 4655.5 4657.1 4657.9 5494.8 5516.3 5530.8 5531.1 5531.6 3584.6 3675.5 3737.5 3848.9 3853.5 5767.2 5778.3 5784.7 5793.7 5800.7 3965.5 3965.5 3965.7 3975.6 3978.7 4036.9 4037.6 4040.3 4045.0 4049.3 4445.5 4517.8 4618.0 4624.4 4625.7 5424.8 5451.9 5459.1 5463.6 5466.4 1417.0 1417.2 1417.9 1418.5 1418.9 946.8 973.3 977.4 990.9 996.2 4848.8 4849.7 4854.4 4857.6 4861.8 5716.2 5732.1 5733.9 5746.3 5758.8 4846.8 4859.5 4862.7 4863.2 4870.4 2905.9 3014.4 3068.0 3091.5 3103.9 4466.0 5370.8 5409.8 5432.4 5497.1 5932.6 5935.6 5943.1 5948.4 5971.2 5456.9 5462.7 5467.5 5467.8 5473.7 5776.1 5791.2 5795.4 5797.0 5803.9 5425.4 5578.7 5663.8 5665.5 5677.5 5383.0 5494.1 5500.0 5506.8 5511.6 3993.5 3997.4 4000.2 4005.3 4006.6 5757.8 5775.1 5782.2 5792.8 5806.1 5388.1 5515.8 5589.6 5595.9 5602.1 5552.3 5571.4 5589.8 5600.2 5605.8 5479.8 5489.8 5496.5 5499.6 5505.5 5514.3 5615.6 5621.4 5635.9 5650.9 5500.3 5503.5 5508.1 5508.8 5511.8 04:45:24 INFO - 2015-12-02 04:45:24,351 DEBUG : BROWSER_OUTPUT: 04:45:24 INFO - 2015-12-02 04:45:24,351 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12260.21 Median:585.07 stddev:14729.39 (2517.5%) stddev-sans-first:14744.56 04:45:24 INFO - 2015-12-02 04:45:24,351 DEBUG : BROWSER_OUTPUT: Values: 571.5 604.8 637.6 679.6 690.1 10371.6 10525.4 10526.8 10532.8 10587.5 10137.6 11281.8 11434.3 11491.9 11545.8 601.6 607.1 754.2 768.4 769.2 608.1 758.5 774.4 774.4 775.5 795.9 804.1 808.6 809.2 809.3 633.8 640.5 776.8 794.3 799.9 584.7 585.5 585.9 586.2 586.2 10242.2 10377.3 10380.9 10393.2 10393.6 10699.6 10945.3 10964.0 11294.9 12137.4 9166.6 9240.7 9504.6 9739.4 9774.1 3168.9 3187.2 3199.5 3221.8 3264.0 41862.2 41871.6 42033.2 42180.0 42379.6 8742.2 8919.8 8977.4 9002.9 9195.6 16310.0 16421.3 16528.7 16560.6 16584.8 6554.7 6577.0 6595.8 6647.2 6677.2 3625.6 3660.6 3707.7 3711.1 3754.5 2569.7 2621.8 2624.2 2635.2 2647.4 494.8 498.4 500.9 504.0 506.2 455.6 531.7 569.6 579.8 588.4 7071.7 7124.9 7538.5 7646.3 7835.4 462.3 571.5 581.3 591.8 597.7 3413.9 3494.7 3524.7 3572.4 3609.1 54248.7 54497.7 54911.0 54930.7 55001.7 46764.3 47313.8 47408.8 47415.8 47418.3 41803.2 42723.4 42998.1 43180.0 43302.4 7187.6 7217.9 7313.9 7320.3 7331.5 31460.8 31813.7 31937.7 32022.4 32624.5 38786.0 38801.6 40898.8 41496.4 41890.4 8408.3 8831.0 8984.3 9026.5 9043.3 9606.2 9721.8 9996.8 10156.4 10156.5 9083.0 9121.9 9397.0 9605.4 9687.6 9407.9 9424.6 9477.6 9712.8 9733.9 8895.1 9092.8 9115.0 9143.4 9743.0 7993.9 8246.8 8336.2 8379.5 8468.2 8060.6 8646.2 8656.2 8709.3 8996.2 04:45:24 INFO - 2015-12-02 04:45:24,352 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:45:24 INFO - 2015-12-02 04:45:24,352 DEBUG : BROWSER_OUTPUT: 04:45:25 INFO - 2015-12-02 04:45:25,047 INFO : Browser exited with error code: 0 04:45:25 INFO - 2015-12-02 04:45:25,065 INFO : Completed test dromaeo_css (00:18:36) 04:45:25 INFO - 2015-12-02 04:45:25,065 INFO : Starting test kraken 04:45:25 INFO - 2015-12-02 04:45:25,065 DEBUG : operating with platform_type : linux_ 04:45:25 INFO - 2015-12-02 04:45:25,065 INFO : Initialising browser for kraken test... 04:45:25 INFO - 2015-12-02 04:45:25,071 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaS2duH/profile http://localhost:51617/getInfo.html 04:45:28 INFO - 2015-12-02 04:45:28,986 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:45:28 INFO - 2015-12-02 04:45:28,986 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:45:28 INFO - 2015-12-02 04:45:28,986 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:45:28 INFO - 2015-12-02 04:45:28,986 DEBUG : BROWSER_OUTPUT: __metrics 04:45:29 INFO - 2015-12-02 04:45:29,090 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:45:30 INFO - 2015-12-02 04:45:30,340 INFO : Browser initialized. 04:45:30 INFO - 2015-12-02 04:45:30,341 INFO : Running cycle 1/1 for kraken test... 04:45:30 INFO - 2015-12-02 04:45:30,341 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaS2duH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:45:42 INFO - 2015-12-02 04:45:42,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 141254656 04:45:42 INFO - 2015-12-02 04:45:42,247 DEBUG : BROWSER_OUTPUT: 04:45:44 INFO - 2015-12-02 04:45:44,827 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51617/tests/kraken/driver.html?testName=audio-beat-detection) 04:45:45 INFO - 2015-12-02 04:45:45,413 DEBUG : BROWSER_OUTPUT: RSS: Main: 175800320 04:45:45 INFO - 2015-12-02 04:45:45,413 DEBUG : BROWSER_OUTPUT: 04:45:48 INFO - 2015-12-02 04:45:48,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51617/tests/kraken/driver.html?testName=audio-dft) 04:45:48 INFO - 2015-12-02 04:45:48,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 163348480 04:45:48 INFO - 2015-12-02 04:45:48,678 DEBUG : BROWSER_OUTPUT: 04:45:51 INFO - 2015-12-02 04:45:51,637 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51617/tests/kraken/driver.html?testName=audio-fft) 04:45:52 INFO - 2015-12-02 04:45:52,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 152092672 04:45:52 INFO - 2015-12-02 04:45:52,198 DEBUG : BROWSER_OUTPUT: 04:45:54 INFO - 2015-12-02 04:45:54,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51617/tests/kraken/driver.html?testName=audio-oscillator) 04:45:54 INFO - 2015-12-02 04:45:54,807 DEBUG : BROWSER_OUTPUT: RSS: Main: 154468352 04:45:54 INFO - 2015-12-02 04:45:54,807 DEBUG : BROWSER_OUTPUT: 04:45:57 INFO - 2015-12-02 04:45:57,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51617/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:45:57 INFO - 2015-12-02 04:45:57,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 155897856 04:45:57 INFO - 2015-12-02 04:45:57,634 DEBUG : BROWSER_OUTPUT: 04:46:00 INFO - 2015-12-02 04:46:00,625 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51617/tests/kraken/driver.html?testName=imaging-darkroom) 04:46:01 INFO - 2015-12-02 04:46:01,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 154763264 04:46:01 INFO - 2015-12-02 04:46:01,207 DEBUG : BROWSER_OUTPUT: 04:46:04 INFO - 2015-12-02 04:46:04,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51617/tests/kraken/driver.html?testName=imaging-desaturate) 04:46:05 INFO - 2015-12-02 04:46:05,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 156622848 04:46:05 INFO - 2015-12-02 04:46:05,222 DEBUG : BROWSER_OUTPUT: 04:46:08 INFO - 2015-12-02 04:46:08,048 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51617/tests/kraken/driver.html?testName=json-parse-financial) 04:46:08 INFO - 2015-12-02 04:46:08,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 155152384 04:46:08 INFO - 2015-12-02 04:46:08,629 DEBUG : BROWSER_OUTPUT: 04:46:10 INFO - 2015-12-02 04:46:10,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51617/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:46:10 INFO - 2015-12-02 04:46:10,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 165457920 04:46:10 INFO - 2015-12-02 04:46:10,945 DEBUG : BROWSER_OUTPUT: 04:46:12 INFO - 2015-12-02 04:46:12,835 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51617/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:46:13 INFO - 2015-12-02 04:46:13,425 DEBUG : BROWSER_OUTPUT: RSS: Main: 164401152 04:46:13 INFO - 2015-12-02 04:46:13,425 DEBUG : BROWSER_OUTPUT: 04:46:15 INFO - 2015-12-02 04:46:15,543 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51617/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:46:16 INFO - 2015-12-02 04:46:16,124 DEBUG : BROWSER_OUTPUT: RSS: Main: 174862336 04:46:16 INFO - 2015-12-02 04:46:16,124 DEBUG : BROWSER_OUTPUT: 04:46:18 INFO - 2015-12-02 04:46:18,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51617/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:46:19 INFO - 2015-12-02 04:46:19,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 181407744 04:46:19 INFO - 2015-12-02 04:46:19,240 DEBUG : BROWSER_OUTPUT: 04:46:21 INFO - 2015-12-02 04:46:21,848 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51617/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:46:22 INFO - 2015-12-02 04:46:22,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 179871744 04:46:22 INFO - 2015-12-02 04:46:22,429 DEBUG : BROWSER_OUTPUT: 04:46:24 INFO - 2015-12-02 04:46:24,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51617/tests/kraken/driver.html?testName=ai-astar) 04:46:24 INFO - 2015-12-02 04:46:24,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 238456832 04:46:24 INFO - 2015-12-02 04:46:24,442 DEBUG : BROWSER_OUTPUT: 04:46:24 INFO - 2015-12-02 04:46:24,445 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:46:24 INFO - 2015-12-02 04:46:24,445 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:46:24 INFO - 2015-12-02 04:46:24,446 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:46:24 INFO - 2015-12-02 04:46:24,446 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:46:24 INFO - 2015-12-02 04:46:24,446 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;114;107;112;112;115;102;114;112;105 04:46:24 INFO - 2015-12-02 04:46:24,446 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;136;157;163;130;155;161;131;177;132 04:46:24 INFO - 2015-12-02 04:46:24,446 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;160;161;161;162;163;162;162 04:46:24 INFO - 2015-12-02 04:46:24,446 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;84;93;72;72;75;110;89;73 04:46:24 INFO - 2015-12-02 04:46:24,446 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;131;93;94;94;135;94;94;131 04:46:24 INFO - 2015-12-02 04:46:24,447 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;111;110;110;109;110;109;110;110 04:46:24 INFO - 2015-12-02 04:46:24,447 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;148;147;147;146;146;147;146;146 04:46:24 INFO - 2015-12-02 04:46:24,447 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;96;96;95;96;95;96 04:46:24 INFO - 2015-12-02 04:46:24,447 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;71;71;71;71;71;72;73;73;69 04:46:24 INFO - 2015-12-02 04:46:24,447 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;69;69;69;69;70;69;71;69;69 04:46:24 INFO - 2015-12-02 04:46:24,447 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;84;85;83;85;84;86;86;83 04:46:24 INFO - 2015-12-02 04:46:24,447 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;123;121;116;127;127;131;127;124;131 04:46:24 INFO - 2015-12-02 04:46:24,447 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;138;150;152;148;147;149;145;146;137 04:46:24 INFO - 2015-12-02 04:46:24,448 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;71;73;68;72;68;70;72;74;70 04:46:24 INFO - 2015-12-02 04:46:24,448 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:46:24 INFO - 2015-12-02 04:46:24,448 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:46:24 INFO - 2015-12-02 04:46:24,448 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,975 04:46:24 INFO - 2015-12-02 04:46:24,448 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:46:24 INFO - 2015-12-02 04:46:24,448 DEBUG : BROWSER_OUTPUT: __startTimestamp1449060384444__endTimestamp 04:46:24 INFO - 2015-12-02 04:46:24,448 DEBUG : BROWSER_OUTPUT: 04:46:24 INFO - 2015-12-02 04:46:24,456 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:46:24 INFO - 2015-12-02 04:46:24,456 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:46:24 INFO - 2015-12-02 04:46:24,456 DEBUG : BROWSER_OUTPUT: 04:46:24 INFO - 2015-12-02 04:46:24,457 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:4.33 (3.9%) stddev-sans-first:4.56 04:46:24 INFO - 2015-12-02 04:46:24,457 DEBUG : BROWSER_OUTPUT: Values: 112.0 114.0 107.0 112.0 112.0 115.0 102.0 114.0 112.0 105.0 04:46:24 INFO - 2015-12-02 04:46:24,457 DEBUG : BROWSER_OUTPUT: 04:46:24 INFO - 2015-12-02 04:46:24,457 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.60 Median:156.00 stddev:16.29 (10.4%) stddev-sans-first:17.20 04:46:24 INFO - 2015-12-02 04:46:24,457 DEBUG : BROWSER_OUTPUT: Values: 154.0 136.0 157.0 163.0 130.0 155.0 161.0 131.0 177.0 132.0 04:46:24 INFO - 2015-12-02 04:46:24,457 DEBUG : BROWSER_OUTPUT: 04:46:24 INFO - 2015-12-02 04:46:24,457 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 04:46:24 INFO - 2015-12-02 04:46:24,457 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 160.0 161.0 161.0 162.0 163.0 162.0 162.0 04:46:24 INFO - 2015-12-02 04:46:24,457 DEBUG : BROWSER_OUTPUT: 04:46:24 INFO - 2015-12-02 04:46:24,457 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.20 Median:74.00 stddev:12.83 (17.3%) stddev-sans-first:13.17 04:46:24 INFO - 2015-12-02 04:46:24,457 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 84.0 93.0 72.0 72.0 75.0 110.0 89.0 73.0 04:46:24 INFO - 2015-12-02 04:46:24,457 DEBUG : BROWSER_OUTPUT: 04:46:24 INFO - 2015-12-02 04:46:24,457 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.40 Median:94.00 stddev:18.62 (19.8%) stddev-sans-first:19.29 04:46:24 INFO - 2015-12-02 04:46:24,457 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 131.0 93.0 94.0 94.0 135.0 94.0 94.0 131.0 04:46:24 INFO - 2015-12-02 04:46:24,457 DEBUG : BROWSER_OUTPUT: 04:46:24 INFO - 2015-12-02 04:46:24,458 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 04:46:24 INFO - 2015-12-02 04:46:24,458 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 111.0 110.0 110.0 109.0 110.0 109.0 110.0 110.0 04:46:24 INFO - 2015-12-02 04:46:24,458 DEBUG : BROWSER_OUTPUT: 04:46:24 INFO - 2015-12-02 04:46:24,458 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 04:46:24 INFO - 2015-12-02 04:46:24,458 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 148.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 04:46:24 INFO - 2015-12-02 04:46:24,458 DEBUG : BROWSER_OUTPUT: 04:46:24 INFO - 2015-12-02 04:46:24,458 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:46:24 INFO - 2015-12-02 04:46:24,458 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 96.0 04:46:24 INFO - 2015-12-02 04:46:24,458 DEBUG : BROWSER_OUTPUT: 04:46:24 INFO - 2015-12-02 04:46:24,458 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.40 Median:71.50 stddev:1.17 (1.6%) stddev-sans-first:1.22 04:46:24 INFO - 2015-12-02 04:46:24,458 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 71.0 71.0 71.0 71.0 72.0 73.0 73.0 69.0 04:46:24 INFO - 2015-12-02 04:46:24,458 DEBUG : BROWSER_OUTPUT: 04:46:24 INFO - 2015-12-02 04:46:24,458 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 04:46:24 INFO - 2015-12-02 04:46:24,458 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 69.0 69.0 69.0 70.0 69.0 71.0 69.0 69.0 04:46:24 INFO - 2015-12-02 04:46:24,458 DEBUG : BROWSER_OUTPUT: 04:46:24 INFO - 2015-12-02 04:46:24,458 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.50 stddev:1.37 (1.6%) stddev-sans-first:1.22 04:46:24 INFO - 2015-12-02 04:46:24,459 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 84.0 85.0 83.0 85.0 84.0 86.0 86.0 83.0 04:46:24 INFO - 2015-12-02 04:46:24,459 DEBUG : BROWSER_OUTPUT: 04:46:24 INFO - 2015-12-02 04:46:24,459 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:127.00 stddev:4.73 (3.7%) stddev-sans-first:4.82 04:46:24 INFO - 2015-12-02 04:46:24,459 DEBUG : BROWSER_OUTPUT: Values: 121.0 123.0 121.0 116.0 127.0 127.0 131.0 127.0 124.0 131.0 04:46:24 INFO - 2015-12-02 04:46:24,459 DEBUG : BROWSER_OUTPUT: 04:46:24 INFO - 2015-12-02 04:46:24,459 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.60 Median:147.50 stddev:4.88 (3.3%) stddev-sans-first:5.14 04:46:24 INFO - 2015-12-02 04:46:24,459 DEBUG : BROWSER_OUTPUT: Values: 144.0 138.0 150.0 152.0 148.0 147.0 149.0 145.0 146.0 137.0 04:46:24 INFO - 2015-12-02 04:46:24,459 DEBUG : BROWSER_OUTPUT: 04:46:24 INFO - 2015-12-02 04:46:24,459 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.50 stddev:2.06 (2.9%) stddev-sans-first:2.09 04:46:24 INFO - 2015-12-02 04:46:24,459 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 73.0 68.0 72.0 68.0 70.0 72.0 74.0 70.0 04:46:24 INFO - 2015-12-02 04:46:24,460 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:46:24 INFO - 2015-12-02 04:46:24,460 DEBUG : BROWSER_OUTPUT: 04:46:25 INFO - 2015-12-02 04:46:25,297 INFO : Browser exited with error code: 0 04:46:25 INFO - 2015-12-02 04:46:25,349 INFO : Completed test kraken (00:01:00) 04:46:25 INFO - 2015-12-02 04:46:25,349 INFO : Starting test v8_7 04:46:25 INFO - 2015-12-02 04:46:25,349 DEBUG : operating with platform_type : linux_ 04:46:25 INFO - 2015-12-02 04:46:25,349 INFO : Initialising browser for v8_7 test... 04:46:25 INFO - 2015-12-02 04:46:25,355 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiJRJ_G/profile http://localhost:51617/getInfo.html 04:46:29 INFO - 2015-12-02 04:46:29,380 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:46:29 INFO - 2015-12-02 04:46:29,380 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:46:29 INFO - 2015-12-02 04:46:29,381 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:46:29 INFO - 2015-12-02 04:46:29,382 DEBUG : BROWSER_OUTPUT: __metrics 04:46:29 INFO - 2015-12-02 04:46:29,478 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:46:30 INFO - 2015-12-02 04:46:30,674 INFO : Browser initialized. 04:46:30 INFO - 2015-12-02 04:46:30,674 INFO : Running cycle 1/1 for v8_7 test... 04:46:30 INFO - 2015-12-02 04:46:30,675 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiJRJ_G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:46:42 INFO - 2015-12-02 04:46:42,636 DEBUG : BROWSER_OUTPUT: RSS: Main: 141197312 04:46:42 INFO - 2015-12-02 04:46:42,637 DEBUG : BROWSER_OUTPUT: 04:47:04 INFO - 2015-12-02 04:47:04,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51617/tests/v8_7/run.html (next: http://localhost:51617/tests/v8_7/run.html) 04:47:04 INFO - 2015-12-02 04:47:04,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 442953728 04:47:04 INFO - 2015-12-02 04:47:04,297 DEBUG : BROWSER_OUTPUT: 04:47:04 INFO - 2015-12-02 04:47:04,297 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:47:04 INFO - 2015-12-02 04:47:04,298 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:47:04 INFO - 2015-12-02 04:47:04,298 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:47:04 INFO - 2015-12-02 04:47:04,298 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:47:04 INFO - 2015-12-02 04:47:04,298 DEBUG : BROWSER_OUTPUT: |0;Richards;167.33601070950468 04:47:04 INFO - 2015-12-02 04:47:04,298 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.05019305019306 04:47:04 INFO - 2015-12-02 04:47:04,298 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.42624789680315 04:47:04 INFO - 2015-12-02 04:47:04,298 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 04:47:04 INFO - 2015-12-02 04:47:04,298 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1974.3589743589744 04:47:04 INFO - 2015-12-02 04:47:04,298 DEBUG : BROWSER_OUTPUT: |5;Earley;781.8608287724785 04:47:04 INFO - 2015-12-02 04:47:04,298 DEBUG : BROWSER_OUTPUT: |6;Boyer;12256.09756097561 04:47:04 INFO - 2015-12-02 04:47:04,298 DEBUG : BROWSER_OUTPUT: |7;RegExp;26000 04:47:04 INFO - 2015-12-02 04:47:04,298 DEBUG : BROWSER_OUTPUT: |8;Splay;626.9592476489029 04:47:04 INFO - 2015-12-02 04:47:04,299 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 04:47:04 INFO - 2015-12-02 04:47:04,299 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:47:04 INFO - 2015-12-02 04:47:04,299 DEBUG : BROWSER_OUTPUT: __startTimestamp1449060424291__endTimestamp 04:47:04 INFO - 2015-12-02 04:47:04,299 DEBUG : BROWSER_OUTPUT: 04:47:04 INFO - 2015-12-02 04:47:04,299 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:47:04 INFO - 2015-12-02 04:47:04,299 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:47:04 INFO - 2015-12-02 04:47:04,299 DEBUG : BROWSER_OUTPUT: 04:47:04 INFO - 2015-12-02 04:47:04,299 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.34 Median:167.34 stddev:0.00 (0.0%) 04:47:04 INFO - 2015-12-02 04:47:04,300 DEBUG : BROWSER_OUTPUT: Values: 167.3 04:47:04 INFO - 2015-12-02 04:47:04,300 DEBUG : BROWSER_OUTPUT: 04:47:04 INFO - 2015-12-02 04:47:04,300 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.05 Median:193.05 stddev:0.00 (0.0%) 04:47:04 INFO - 2015-12-02 04:47:04,300 DEBUG : BROWSER_OUTPUT: Values: 193.1 04:47:04 INFO - 2015-12-02 04:47:04,300 DEBUG : BROWSER_OUTPUT: 04:47:04 INFO - 2015-12-02 04:47:04,300 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 04:47:04 INFO - 2015-12-02 04:47:04,300 DEBUG : BROWSER_OUTPUT: Values: 280.4 04:47:04 INFO - 2015-12-02 04:47:04,300 DEBUG : BROWSER_OUTPUT: 04:47:04 INFO - 2015-12-02 04:47:04,301 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 04:47:04 INFO - 2015-12-02 04:47:04,301 DEBUG : BROWSER_OUTPUT: Values: 5186.5 04:47:04 INFO - 2015-12-02 04:47:04,301 DEBUG : BROWSER_OUTPUT: 04:47:04 INFO - 2015-12-02 04:47:04,301 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1974.36 Median:1974.36 stddev:0.00 (0.0%) 04:47:04 INFO - 2015-12-02 04:47:04,301 DEBUG : BROWSER_OUTPUT: Values: 1974.4 04:47:04 INFO - 2015-12-02 04:47:04,301 DEBUG : BROWSER_OUTPUT: 04:47:04 INFO - 2015-12-02 04:47:04,301 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:781.86 Median:781.86 stddev:0.00 (0.0%) 04:47:04 INFO - 2015-12-02 04:47:04,301 DEBUG : BROWSER_OUTPUT: Values: 781.9 04:47:04 INFO - 2015-12-02 04:47:04,302 DEBUG : BROWSER_OUTPUT: 04:47:04 INFO - 2015-12-02 04:47:04,302 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 04:47:04 INFO - 2015-12-02 04:47:04,302 DEBUG : BROWSER_OUTPUT: Values: 12256.1 04:47:04 INFO - 2015-12-02 04:47:04,302 DEBUG : BROWSER_OUTPUT: 04:47:04 INFO - 2015-12-02 04:47:04,302 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26000.00 Median:26000.00 stddev:0.00 (0.0%) 04:47:04 INFO - 2015-12-02 04:47:04,302 DEBUG : BROWSER_OUTPUT: Values: 26000.0 04:47:04 INFO - 2015-12-02 04:47:04,302 DEBUG : BROWSER_OUTPUT: 04:47:04 INFO - 2015-12-02 04:47:04,302 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:626.96 Median:626.96 stddev:0.00 (0.0%) 04:47:04 INFO - 2015-12-02 04:47:04,303 DEBUG : BROWSER_OUTPUT: Values: 627.0 04:47:04 INFO - 2015-12-02 04:47:04,303 DEBUG : BROWSER_OUTPUT: 04:47:04 INFO - 2015-12-02 04:47:04,303 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 04:47:04 INFO - 2015-12-02 04:47:04,303 DEBUG : BROWSER_OUTPUT: Values: 4830.9 04:47:04 INFO - 2015-12-02 04:47:04,303 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:47:04 INFO - 2015-12-02 04:47:04,303 DEBUG : BROWSER_OUTPUT: 04:47:05 INFO - 2015-12-02 04:47:05,193 INFO : Browser exited with error code: 0 04:47:05 INFO - 2015-12-02 04:47:05,210 INFO : Completed test v8_7 (00:00:39) 04:47:05 INFO - 2015-12-02 04:47:05,310 INFO : Completed test suite (00:20:16) 04:47:05 INFO - 2015-12-02 04:47:05,310 DEBUG : Working with test: dromaeo_css 04:47:05 INFO - 2015-12-02 04:47:05,310 DEBUG : Generating results file: dromaeo_css 04:47:05 INFO - 2015-12-02 04:47:05,311 DEBUG : Working with test: kraken 04:47:05 INFO - 2015-12-02 04:47:05,311 DEBUG : Generating results file: kraken 04:47:05 INFO - 2015-12-02 04:47:05,312 INFO : javascript benchmark 04:47:05 INFO - 2015-12-02 04:47:05,312 DEBUG : Working with test: v8_7 04:47:05 INFO - 2015-12-02 04:47:05,312 DEBUG : Generating results file: v8_7 04:47:05 INFO - 2015-12-02 04:47:05,312 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:47:05 INFO - 2015-12-02 04:47:05,370 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 04:47:05 INFO - 2015-12-02 04:47:05,370 DEBUG : process_Request line: dromaeo_css 6240.89 graph.html#tests=[[72,132,35]] 04:47:05 INFO - 2015-12-02 04:47:05,370 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:47:05 INFO - 2015-12-02 04:47:05,407 DEBUG : process_Request line: kraken 1526.20 graph.html#tests=[[232,132,35]] 04:47:05 INFO - 2015-12-02 04:47:05,407 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:47:05 INFO - 2015-12-02 04:47:05,438 DEBUG : process_Request line: v8_7 19719.38 graph.html#tests=[[230,132,35]] 04:47:05 INFO - 2015-12-02 04:47:05,439 INFO : javascript benchmark 04:47:05 INFO - 2015-12-02 04:47:05,443 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2599.415131595391, 2690.816040941985, 2701.6487856578665, 2707.7021527631955, 2722.278596172014, 4432.445944256968, 4546.3180522921575, 4607.470140933798, 4619.514950930155, 4634.351190833286, 4511.90976180477, 4543.204939135655, 4584.793684284207, 4596.264597664366, 4621.884452888671, 4265.957340426595, 4306.289462238727, 4307.569243075683, 4326.7187632803925, 4346.0, 4102.487189101363, 4333.739975601474, 4364.978175109136, 4388.802503887333, 4394.648428125743, 4202.978985105055, 4263.445752052245, 4271.444712187426, 4290.442242508485, 4315.4821421429315, 4268.103698223377, 4269.274223382033, 4275.615194632498, 4310.52584215736, 4313.41768861206, 4092.7339722918214, 4242.957570424287, 4269.124829409963, 4273.059926816127, 4290.077633308822, 4432.889177770549, 4502.684812063157, 4515.4129963104915, 4520.457545094577, 4554.658400619966, 4976.4277108132665, 4982.850514484571, 4993.375828021497, 4995.525425084611, 5061.240813877911, 4885.804567817283, 5014.24786282057, 5020.497950204986, 5026.874328141789, 5028.270900719375, 4577.656675749332, 4633.003904160588, 4638.698484598558, 4647.767611619439, 4707.152712511781, 5146.382434107856, 5151.613628977767, 5157.484251574888, 5168.948310516922, 5196.9740151299, 4754.78603462845, 4929.531694489017, 4961.305417241589, 4964.0, 5020.347354843847, 4976.4525902150735, 4976.527229913152, 4982.103221420107, 5074.847754567369, 5092.821751238689, 4974.751262436864, 4976.328195693607, 4983.476734942851, 4991.226359914219, 5046.0, 4705.247160454311, 4945.23348880924, 4945.802167913315, 4951.752412379438, 4998.90002199954, 4123.628873401348, 4182.811773470201, 4186.455760751144, 4205.873823785291, 4245.27830268855, 3722.7952462614817, 3726.925461490755, 3733.4026555751493, 3746.3256613809776, 3753.3806921857586, 4169.395437661522, 4337.067530480962, 4337.609615134653, 4374.409454723572, 4380.6057454829215, 4930.433000204951, 4930.926036109461, 4956.776945037482, 4963.057019166346, 4990.201567749215, 4231.407602935591, 4279.850205242801, 4287.721298115613, 4296.462942132233, 4342.609165175149, 4445.799939002753, 4455.68810183284, 4467.865964021084, 4490.730556166641, 4509.413776209072, 4570.314452832102, 4685.6017238535105, 4685.625149987993, 4688.484266730725, 4779.761011949458, 4993.300937868774, 5019.498050194951, 5020.171671674133, 5020.648554601143, 5060.291559181791, 4757.09615173116, 4758.738269395078, 4760.047990401864, 4763.261694437368, 4800.0, 4694.3427920090535, 4707.152712511781, 4710.929336059893, 4763.809447622057, 4768.189407800752, 4807.278908163664, 4848.515148485123, 4887.218045112765, 4892.68197567157, 4930.457649658463, 4816.783244753924, 4842.055799119138, 4877.804887804448, 4880.31675565414, 4921.63087768426, 4695.22528782747, 4844.757762111951, 4882.877928051827, 4886.242632391843, 4914.434839993446, 4667.416572928384, 4746.33551302811, 4757.809687612456, 4760.833370832004, 4786.521347865186, 4878.195097808822, 4906.975465122794, 4912.778924948315, 4914.385701787277, 4921.630877684116, 4795.976020119877, 4820.39745031871, 4823.27650852375, 4824.107540105092, 4869.853904382874], "unit": "ms", "name": "dojo.html", "value": 4565.996918588134}, {"lowerIsBetter": false, "replicates": [535.0689799748437, 551.3934671860952, 552.138663684652, 565.183310116881, 570.9371969083397, 28522.14433566994, 29084.127476175723, 37902.810485947564, 38149.42775858357, 38189.427158592574, 40137.19725605486, 40641.187176256455, 40648.79675601625, 40709.18581628366, 40810.38784418236, 7051.823704407379, 7763.961180194091, 7918.524888506708, 7922.841543169133, 7926.326262267714, 6960.860782784342, 7026.754063607775, 7037.788866334018, 7039.436845052409, 10125.797484050314, 9974.551145198484, 10165.135963443116, 10172.847407288897, 10194.439305838176, 10197.541110650001, 10032.347897386682, 10196.541155648014, 10197.796044079114, 10198.490075496196, 10208.948955255251, 7219.35025847671, 7403.888941665879, 10189.847152292721, 10455.215858810543, 10458.477076146239, 37766.0, 37882.0, 37966.43050354247, 38290.61709382899, 38311.808440957895, 2809.9297517562222, 2870.0, 2877.568364745284, 2890.682024977251, 2913.941721165586, 28647.0, 28891.133266002053, 29058.854705726546, 29110.854445727637, 29554.556681649792, 3439.4496880499, 3466.098814308298, 3498.422760244582, 3510.824458777051, 3602.765820221677, 216870.0, 217826.0, 218337.0, 218543.0, 218736.0, 51332.74333628383, 55549.444505555235, 55856.441435585126, 55900.44099559034, 55970.72014639982, 42534.787326063175, 59187.40812591905, 60400.093998590055, 60404.09393859096, 60524.0, 12109.515619375126, 12404.937975310066, 12521.0, 12531.624051278477, 12536.874631253753, 8571.100034496412, 8634.222919937236, 8652.913470865336, 8660.956695216484, 8690.04409514953, 19081.522961926064, 19145.329913452963, 19255.8074419254, 19392.8060719391, 19399.515012124528, 7096.432285417154, 7395.482316237919, 7432.479726419098, 7477.214892436325, 7507.286807753255, 815.5759005317202, 851.2338894994431, 866.7616405488415, 880.3573391424168, 882.7440042387635, 24446.0, 24673.383165421008, 24795.87602061978, 24820.131295404575, 24838.627420588706, 967.3422072990294, 1003.3879333606494, 1055.1084333737979, 1061.5965932945585, 1074.5648012554927, 12242.571509997286, 12751.107422480338, 12853.871461285455, 12859.0998630095, 12910.483580656857, 266484.0, 270179.0, 270443.0, 271399.0, 271832.0, 45296.3205551917, 45344.3198352025, 45368.31947520724, 45407.772961134986, 45695.54304456913, 1154.1920655541155, 1157.0280963990288, 1186.8160435132568, 1191.880811918801, 1194.3013337197663, 21720.565588688452, 23883.402914927265, 25956.35109122287, 26283.737162628895, 29014.27464313409, 39103.0, 39373.0, 39377.60622393854, 39384.40923386094, 39465.40801888031, 176465.0, 176984.0, 177638.0, 178058.0, 230340.0, 22839.0, 28964.0, 29159.416811664072, 29577.408451831274, 29691.0, 32314.0, 38641.0, 38818.0, 39806.203875922896, 39986.60013399829, 31644.683553165094, 31834.36331273408, 32236.516452253705, 32659.510107347935, 32902.506462402605, 32318.67681323251, 32936.176595585304, 33056.66943330536, 34500.82749586236, 37318.62681373151, 29946.850265748533, 30022.399552009276, 30029.249268768457, 30037.69962300349, 30609.0, 28054.85972570124, 29023.564646529896, 29702.327115366323, 30152.0, 31625.8418707905, 23047.423814404774, 23490.530189395773, 23497.41256468602, 25128.62307065359, 25130.874345628155], "unit": "ms", "name": "ext.html", "value": 16654.473992740535}, {"lowerIsBetter": false, "replicates": [316.6263808705728, 319.88164379179705, 323.936832317698, 325.9136328872849, 326.2284696692322, 12440.81338779919, 12832.139339795724, 14741.926290368547, 15134.848651513495, 15354.385824567018, 11606.187566870323, 13349.59951201463, 13862.792058119136, 14411.855881441208, 14468.059576127544, 3903.687704983609, 4934.851954441364, 5009.298698182258, 5033.119204139261, 5070.112730272206, 4963.975180124113, 4971.105201063807, 4997.625178111638, 5004.524570165829, 5012.598992080643, 4919.680220785637, 4962.727050012248, 4997.0, 5073.441921388644, 5073.974630126844, 5015.172496538067, 5018.34761481007, 5022.397312322526, 5024.447310795809, 5024.82413115541, 4437.090396468716, 4444.644428445717, 4447.08834688888, 4454.086912183027, 4455.866324010285, 19762.11070501831, 19928.80071199284, 20525.0, 21198.258060967946, 21337.0, 1937.5737337785665, 2010.6380851446734, 2032.7967203279702, 2046.1201683276186, 2062.0720675695998, 13453.469634153038, 13547.119437236646, 13689.726205475834, 14037.087589306764, 14238.715225695429, 1771.070188151231, 1802.7476153338544, 1919.5968846542244, 1923.0480911948675, 1930.94207173785, 58083.41916580822, 58191.616766467065, 58704.41295587032, 60229.0, 64151.358486415, 15424.614384640474, 15453.845461545465, 15473.767893481607, 15479.0, 15586.90891637597, 18590.721139182922, 19140.90429547871, 20619.381418557467, 23709.7629023711, 23778.762212378002, 7756.806079847936, 7836.686532538634, 7899.68401263943, 7931.286184243446, 7953.602319883983, 6551.8362040948405, 6568.1789776277965, 6607.174103237096, 6624.403803657694, 6644.900326495106, 7385.519941203805, 7480.663370148356, 7505.924940750632, 7526.736564220226, 7635.988990478607, 2885.6825749167574, 2943.823370597771, 2972.331225474251, 2974.6430428348303, 3101.9224519387194, 781.2655903893348, 837.3092198935902, 888.8266787976282, 919.852823548229, 988.3427520698655, 15168.165750883807, 15416.614584635474, 15507.302171402314, 15649.765253521206, 15768.76346854798, 787.5668382389778, 810.4165001199127, 834.4784509681449, 876.1632640827994, 948.137195152408, 7173.92826071743, 8476.449030812977, 8677.739667809976, 8742.08208138149, 8823.735287941372, 485054.0, 489680.0, 490707.0, 497442.0, 498270.0, 49730.95579426964, 69371.3062869375, 69591.65204174048, 70076.0, 70920.64539677268, 981.8870829854516, 1003.4079892863246, 1004.2267454060333, 1020.1838529176629, 1021.7598864266891, 8741.694040708544, 8881.955590222007, 14539.41842326295, 14561.126332420088, 14781.630459238606, 31804.522932155574, 32738.1815454606, 33140.502892457116, 33588.49617255792, 33916.660833392336, 41434.79282603568, 43538.564614353454, 43540.34689479597, 43673.0, 47909.0, 13571.59285221445, 13757.17456952546, 14265.072770269899, 14271.500497482539, 14302.642433939234, 17259.568510787332, 17268.65462690714, 17328.39350622722, 17371.7394239084, 17681.115944202997, 13613.209292095295, 13867.930660347038, 14184.290785460893, 14306.0, 14647.194404307866, 14143.717125657635, 14313.928430357782, 14348.426062957366, 14734.115953042852, 15179.696406071596, 14186.148831070168, 14272.072315299472, 14343.354549045109, 15013.324400402227, 15350.692986140439, 13436.798448023483, 13575.25336106484, 13585.864141358856, 13709.383077761724, 13750.312484375941, 7806.609669516615, 8133.7966550834335, 8135.064467586303, 14971.101733895566, 15124.319405626993], "unit": "ms", "name": "jquery.html", "value": 9024.938717980667}, {"lowerIsBetter": false, "replicates": [1400.2018849255928, 1548.45803968611, 1598.0252046251785, 1619.7570364445335, 1630.6331075508006, 5641.097424412095, 6431.742730290789, 6606.8678626427445, 6655.567388119769, 6664.500162487809, 6487.610743355402, 6629.834254143649, 6635.568688035274, 6635.966820165904, 6639.966800166005, 1642.6468309313495, 1671.8996860188367, 1674.5646132005704, 1913.674675305198, 1940.4372731907729, 1924.509250141212, 1955.1104247567323, 1966.1840336260434, 1968.5767559974602, 1970.0, 1879.6146789908037, 1896.0, 1908.9045547722628, 1930.9227630894748, 1931.449536881989, 1952.2093552111346, 1972.960540789176, 1975.170428420067, 1975.387629834756, 1977.772556156046, 1937.2347922570646, 1972.9704054439194, 1975.4666240115232, 1978.9505262368411, 1979.712941623471, 6541.47668186544, 6589.275179730226, 6592.1100651411925, 6593.307702691196, 6596.175478065242, 3561.1097225693575, 3616.367135751233, 3639.890803275906, 3642.6175251598465, 3645.9453108203397, 2481.1440053181623, 2547.235829251236, 2553.9489210215693, 2566.396896729267, 2595.3122422558035, 765.4450523370567, 835.4569529805614, 853.1212850763724, 897.0356866368679, 947.9193719160163, 8633.913660863374, 8644.22202001823, 8673.826523469495, 8678.826423471559, 8681.30549556034, 3464.6188919218866, 3498.5976612689356, 3549.2369140634887, 3562.786232826039, 3565.8038807865814, 7532.661030253652, 7541.660625271876, 7546.056742907137, 7564.546127232384, 7565.6217189140325, 3720.162963333228, 3728.179800443898, 3753.136778540896, 3759.3045286622064, 3788.791616461066, 3386.779859309137, 3389.7288216942584, 3391.372596069735, 3395.8471868765964, 3413.914652133667, 2846.075025616683, 2905.0994191800187, 3134.561161437355, 3140.0893740815363, 3189.6172459304566, 938.2072149034055, 965.9227261819037, 966.8839739231337, 967.8693376394097, 970.815545046439, 920.5765347939889, 920.8296465153834, 951.2104952889224, 1087.5323610847254, 1176.2883455509464, 6240.719167637377, 6259.530535209787, 6267.4986001119805, 6289.905651415233, 6310.274318453345, 980.568549838069, 984.7981163861391, 1012.9088382045651, 1013.6097602423121, 1014.5637375928421, 5062.088824011713, 5110.0, 5119.48805119485, 5121.897562048738, 5122.052420302181, 7640.770776876702, 7743.264389883065, 7881.921180788233, 7882.093559240646, 7983.8403231935035, 7861.213878612093, 7866.213378662088, 7878.960605196938, 7889.605519723991, 7928.682852685828, 6111.663858487737, 6163.3836616338, 6187.783427580103, 6223.37766223374, 6229.377062293825, 5909.645421274738, 6019.72911219005, 6081.817545473643, 6095.908561371494, 6100.786472473442, 7004.579725216503, 7051.823704407431, 7102.0, 7134.1795693495915, 7215.458840586872, 7162.928370716226, 7252.0, 7360.484766066324, 7360.66876990526, 7376.815579610553, 5640.971795140998, 5676.914846277226, 5707.457791509966, 5707.714614269353, 5711.428857114255, 5327.280817089643, 5476.479734425223, 6410.775622853178, 6449.290578036506, 6460.644664543495, 5599.468050535193, 5835.7373918174635, 5841.970790146022, 5975.850603734942, 5999.280086389661, 5800.854978625568, 5878.3239927407185, 5879.059350503899, 5915.645061296336, 6029.788957386646, 5765.0, 6055.788047418319, 6057.242844644419, 6062.696865156637, 6063.787767428119, 5438.10271305246, 5495.587830912617, 5507.504324610804, 5635.098384258663, 5642.858928526655, 5457.372402173642, 5458.836234912959, 5468.890622187454, 5481.068218402961, 5485.341758988788], "unit": "ms", "name": "mootools.html", "value": 3783.3498881953406}, {"lowerIsBetter": false, "replicates": [268.6239265028959, 275.0212223055118, 276.48711639907964, 287.00266573656535, 287.50979579816413, 5187.092258854705, 5236.764345604447, 5310.336207974004, 5333.519983201511, 5341.4124446310925, 5093.9235911461265, 5219.191025391061, 5225.268462415255, 5242.606804489659, 5253.185756207784, 4110.219058378913, 4111.239420707178, 4112.992316882368, 4114.444549985758, 4124.113315637137, 3837.9232415351676, 3943.2902077626018, 3994.920101597966, 4112.259793237216, 4113.979430102845, 4045.2111838191563, 4046.898827529306, 4072.36878283865, 4075.286824805662, 4077.612626800449, 4058.0463591056227, 4061.1065565575673, 4065.1666408386504, 4070.005697208376, 4072.490938632671, 3553.129483276614, 3555.484454754046, 3556.697680697144, 3562.0, 3564.322778672044, 4976.751162441863, 5084.3644544431945, 5085.974570127126, 5086.059079070347, 5089.440161582223, 4648.651351148644, 4652.209124448852, 4655.51117132703, 4657.138429390539, 4657.930131048037, 5494.835154945358, 5516.282883225195, 5530.778768849241, 5531.115021596565, 5531.640443371168, 3584.605693373727, 3675.5038069860493, 3737.5328083989502, 3848.8845334640005, 3853.460515527828, 5767.1637612546365, 5778.306603207642, 5784.710764461718, 5793.710314484259, 5800.738966746507, 3965.464662270614, 3965.5439624442984, 3965.6629186518894, 3975.582563830814, 3978.701597380208, 4036.858709945138, 4037.596240375939, 4040.313146765057, 4044.9595504044582, 4049.271131196354, 4445.466544014739, 4517.796699148546, 4617.953820461819, 4624.445066591963, 4625.7455839929125, 5424.755885985141, 5451.945480545223, 5459.071957767189, 5463.617546771768, 5466.426025267369, 1417.0364152376276, 1417.206364435919, 1417.8511256318145, 1418.4680744720729, 1418.900676952624, 946.8295706772709, 973.3089506450358, 977.4233202410612, 990.9405435673883, 996.2478328861808, 4848.80604775805, 4849.684770489906, 4854.441739200037, 4857.611391088704, 4861.781219845116, 5716.1997320375185, 5732.082866741302, 5733.88532229353, 5746.2529871116485, 5758.798442054508, 4846.75766211688, 4859.538343857399, 4862.7325497098, 4863.1732605457155, 4870.391201099863, 2905.86418982048, 3014.427258820817, 3067.98466007673, 3091.5053591425262, 3103.90688279352, 4465.977670111629, 5370.838874833761, 5409.756560954766, 5432.429594892558, 5497.147942068986, 5932.644041357532, 5935.643861368331, 5943.108533719977, 5948.434898684618, 5971.19388882504, 5456.90861827636, 5462.672239665632, 5467.480589344006, 5467.808626698046, 5473.67157970523, 5776.075827867521, 5791.218185544897, 5795.420457954171, 5796.971015144897, 5803.883922321615, 5425.376081750649, 5578.748956296895, 5663.830085097454, 5665.518430933417, 5677.5457963362005, 5383.0, 5494.148406996922, 5500.0, 5506.779728810803, 5511.586631002771, 3993.4608827807874, 3997.360422332413, 4000.1999600079516, 4005.2990726622143, 4006.59934006597, 5757.79847705345, 5775.133729940375, 5782.190493330853, 5792.768289268382, 5806.129080637938, 5388.057090009311, 5515.751791169327, 5589.636673616202, 5595.916061259166, 5602.075657516464, 5552.305961754781, 5571.4428557143965, 5589.80435684749, 5600.215969764155, 5605.831825045255, 5479.780808767764, 5489.780408783604, 5496.450354964471, 5499.642523235977, 5505.532029777513, 5514.338279406336, 5615.550755939434, 5621.381648018796, 5635.915461268166, 5650.915236271541, 5500.339959204921, 5503.477169668875, 5508.0911649578975, 5508.788066625336, 5511.751971161227], "unit": "ms", "name": "prototype.html", "value": 4148.375733046039}, {"lowerIsBetter": false, "replicates": [571.5113577890903, 604.812508122482, 637.6461064109418, 679.6296018669824, 690.078744875591, 10371.636992705256, 10525.421101839396, 10526.789464210711, 10532.789344213112, 10587.470626468674, 10137.594496220161, 11281.774364512725, 11434.313941163537, 11491.885081149187, 11545.769084618303, 601.5909181756404, 607.1196764691193, 754.1892465599475, 768.3814529303908, 769.2192424688945, 608.0696534302502, 758.4993904023346, 774.3727580659655, 774.4385320642546, 775.5385545600359, 795.8607243732353, 804.1476035402463, 808.5714571277204, 809.2312303311847, 809.3080416244114, 633.8415396150963, 640.5036097024796, 776.7747353267546, 794.2772077409529, 799.8800179973022, 584.6696616411756, 585.4701495146899, 585.935547089824, 586.1734953715242, 586.2349633727983, 10242.180625549938, 10377.325473844176, 10380.896191038068, 10393.22050846182, 10393.636222732168, 10699.572017119384, 10945.343279403261, 10964.013238808546, 11294.887051129466, 12137.393130343537, 9166.633334666605, 9240.722778316662, 9504.572294246775, 9739.41563506192, 9774.12032917041, 3168.8732450701946, 3187.15540381799, 3199.504076868089, 3221.8066915985114, 3263.9836800816083, 41862.16275674469, 41871.58128418707, 42033.1593368134, 42180.0, 42379.57620423818, 8742.169493898069, 8919.821603568022, 8977.416467929694, 9002.86495702565, 9195.586198621078, 16310.0, 16421.261043253082, 16528.66942661164, 16560.585985350463, 16584.83415165857, 6554.680490479571, 6577.0, 6595.8021259362295, 6647.202335719745, 6677.198736151693, 3625.5830579483168, 3660.5607327120915, 3707.7404581679025, 3711.1278849470355, 3754.4743735877, 2569.6659434273424, 2621.7902567794913, 2624.2258533732593, 2635.222609330252, 2647.4440367523034, 494.7946602160063, 498.35960790384183, 500.9223570346602, 504.009621094551, 506.21283903530366, 455.5694868349444, 531.6730210920333, 569.5728203847115, 579.7999690106991, 588.3812075209571, 7071.681774320065, 7124.8575028499135, 7538.509996850187, 7646.273604007611, 7835.373170146375, 462.3111563769959, 571.4885177765876, 581.2734082397004, 591.7928724946235, 597.6623207887617, 3413.8975830725117, 3494.685478306965, 3524.665156810099, 3572.4284114541547, 3609.097725568608, 54248.728756355966, 54497.72751136219, 54911.0, 54930.72534637381, 55001.72499137559, 46764.29853552199, 47313.763431182626, 47408.76295618569, 47415.762921185866, 47418.28872566914, 41803.163936721096, 42723.35914961278, 42998.14003719908, 43180.0, 43302.35046474305, 7187.604681742554, 7217.891731624135, 7313.890291645736, 7320.304571065741, 7331.450141239535, 31460.842695786374, 31813.68186318107, 31937.68062319347, 32022.359552808346, 32624.510632341007, 38786.0, 38801.6119838798, 40898.79550602228, 41496.377554336104, 41890.37164442475, 8408.285295749929, 8830.955845220733, 8984.281257499253, 9026.45841249527, 9043.278475638846, 9606.231501480004, 9721.805563888824, 9996.800063998824, 10156.39061656303, 10156.542955567165, 9083.0, 9121.863172052292, 9396.953015235154, 9605.37565058269, 9687.612495500101, 9407.85888211691, 9424.575894084646, 9477.573509191965, 9712.757181070247, 9733.9026609733, 8895.110488951053, 9092.772680683036, 9115.0, 9143.405678630868, 9743.0, 7993.920060799318, 8246.793830154294, 8336.249737523653, 8379.49723016621, 8468.237858592756, 8060.596970151351, 8646.221840034426, 8656.22094011542, 8709.303255739398, 8996.235319997873], "unit": "ms", "name": "yui.html", "value": 5484.834728674905}], "name": "dromaeo_css", "value": 6240.8904687291815}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 107.0, 112.0, 112.0, 115.0, 102.0, 114.0, 112.0, 105.0], "unit": "ms", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [154.0, 136.0, 157.0, 163.0, 130.0, 155.0, 161.0, 131.0, 177.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 160.0, 161.0, 161.0, 162.0, 163.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 84.0, 93.0, 72.0, 72.0, 75.0, 110.0, 89.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 131.0, 93.0, 94.0, 94.0, 135.0, 94.0, 94.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 111.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 148.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 71.0, 71.0, 71.0, 71.0, 72.0, 73.0, 73.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.4}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 69.0, 69.0, 70.0, 69.0, 71.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 84.0, 85.0, 83.0, 85.0, 84.0, 86.0, 86.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.1}, {"lowerIsBetter": true, "replicates": [121.0, 123.0, 121.0, 116.0, 127.0, 127.0, 131.0, 127.0, 124.0, 131.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.8}, {"lowerIsBetter": true, "replicates": [144.0, 138.0, 150.0, 152.0, 148.0, 147.0, 149.0, 145.0, 146.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.6}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 73.0, 68.0, 72.0, 68.0, 70.0, 72.0, 74.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.7}], "name": "kraken", "value": 1526.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.33601070950468], "unit": "score", "name": "Richards", "value": 210.96475200000003}, {"lowerIsBetter": false, "replicates": [193.05019305019306], "unit": "score", "name": "DeltaBlue", "value": 342.49123999999995}, {"lowerIsBetter": false, "replicates": [280.42624789680315], "unit": "score", "name": "Encrypt", "value": 949.2014460000001}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1974.3589743589744], "unit": "score", "name": "RayTrace", "value": 374.7996233766234}, {"lowerIsBetter": false, "replicates": [781.8608287724785], "unit": "score", "name": "Earley", "value": 852.4061770000001}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [26000.0], "unit": "score", "name": "RegExp", "value": 35.037884615384634}, {"lowerIsBetter": false, "replicates": [626.9592476489029], "unit": "score", "name": "Splay", "value": 129.97814499999998}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19719.37679786442}]} 04:47:05 INFO - RETURN: dromaeo_css: 6240.89 04:47:05 INFO - RETURN: kraken: 1526.20 04:47:05 INFO - RETURN: v8_7: 19719.38 04:47:05 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19719.38"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1526.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6240.89"}}} 04:47:05 INFO - Return code: 0 04:47:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:47:05 INFO - # TBPL SUCCESS # 04:47:05 INFO - Running post-action listener: _resource_record_post_action 04:47:05 INFO - Running post-run listener: _resource_record_post_run 04:47:06 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 139264; Write bytes: 504291328; Read time: 224; Write time: 524164 04:47:06 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 229335040; Read time: 0; Write time: 348560 04:47:06 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 139264; Write bytes: 274665472; Read time: 224; Write time: 175572 04:47:06 INFO - Running post-run listener: _upload_blobber_files 04:47:06 INFO - Blob upload gear active. 04:47:06 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:47:06 INFO - Copying logs to upload dir... 04:47:06 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1265.448642 ========= master_lag: 0.73 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-02 04:47:06.446966) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 04:47:06.453908) ========= 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=d333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009882 build_url: 'https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 04:47:06.483770) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 04:47:06.484217) ========= 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=d333f129428bd91e5d9d687c000001bd-1449059159.668253-913468219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004649 ========= master_lag: 0.66 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 04:47:07.144972) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 04:47:07.145378) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 04:47:07.145741) ========= ========= Total master_lag: 1.53 =========