builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1449059171.0 results: success (0) buildid: 20151127103731 builduid: 3f081eb818b04624a3a075611ac903f2 revision: f48352b311eb120a09347efce60ae9045401858c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 04:26:11.003805) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 04:26:11.004271) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 04:26:11.004555) ========= 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=e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006244 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 04:26:11.027189) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 04:26:11.027483) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 04:26:11.040728) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 04:26:11.041015) ========= 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=e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 04:26:11.089841) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 04:26:11.090150) ========= 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:26:11.090493) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 04:26:11.090824) ========= 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=e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-02 04:26:11-- 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% 83.3M=0s 2015-12-02 04:26:11 (83.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153463 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 04:26:11.256754) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 04:26:11.257117) ========= 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=e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023099 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 04:26:11.307000) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-02 04:26:11.307339) ========= 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=e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-02 04:26:11,730 truncating revision to first 12 chars 2015-12-02 04:26:11,730 Setting DEBUG logging. 2015-12-02 04:26:11,730 attempt 1/10 2015-12-02 04:26:11,730 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:13,083 unpacking tar archive at: fx-team-f48352b311eb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.635762 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-02 04:26:12.956171) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 04:26:12.956492) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 04:26:12.964504) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 04:26:12.964850) ========= 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:12.965282) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-02 04:26:12.965577) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:26:13 INFO - MultiFileLogger online at 20151202 04:26:13 in /builds/slave/test 04:26:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:26:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:26:13 INFO - {'append_to_log': False, 04:26:13 INFO - 'base_work_dir': '/builds/slave/test', 04:26:13 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:26:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:26:13 INFO - 'branch': 'Fx-Team-Non-PGO', 04:26:13 INFO - 'buildbot_json_path': 'buildprops.json', 04:26:13 INFO - 'config_files': ('talos/linux_config.py',), 04:26:13 INFO - 'default_actions': ('clobber', 04:26:13 INFO - 'read-buildbot-config', 04:26:13 INFO - 'download-and-extract', 04:26:13 INFO - 'populate-webroot', 04:26:13 INFO - 'create-virtualenv', 04:26:13 INFO - 'install', 04:26:13 INFO - 'run-tests'), 04:26:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:26:13 INFO - 'download_minidump_stackwalk': True, 04:26:13 INFO - 'download_symbols': 'ondemand', 04:26:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:26:13 INFO - 'tooltool.py': '/tools/tooltool.py', 04:26:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:26:13 INFO - '/tools/misc-python/virtualenv.py')}, 04:26:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:26:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:26:13 INFO - 'installer_path': 'installer.exe', 04:26:13 INFO - 'log_level': 'info', 04:26:13 INFO - 'log_name': 'talos', 04:26:13 INFO - 'log_to_console': True, 04:26:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:26:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:26:13 INFO - 'opt_config_files': (), 04:26:13 INFO - 'pip_index': False, 04:26:13 INFO - 'sps_profile': False, 04:26:13 INFO - 'sps_profile_interval': 0, 04:26:13 INFO - 'suite': 'dromaeojs-e10s', 04:26:13 INFO - 'system_bits': '64', 04:26:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:26:13 INFO - 'title': 'talos-linux64-ix-023', 04:26:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:26:13 INFO - 'use_talos_json': True, 04:26:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:26:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:26:13 INFO - 'work_dir': 'build'} 04:26:13 INFO - ##### 04:26:13 INFO - ##### Running clobber step. 04:26:13 INFO - ##### 04:26:13 INFO - Running pre-action listener: _resource_record_pre_action 04:26:13 INFO - Running main action method: clobber 04:26:13 INFO - rmtree: /builds/slave/test/build 04:26:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:26:13 INFO - Running post-action listener: _resource_record_post_action 04:26:13 INFO - ##### 04:26:13 INFO - ##### Running read-buildbot-config step. 04:26:13 INFO - ##### 04:26:13 INFO - Running pre-action listener: _resource_record_pre_action 04:26:13 INFO - Running main action method: read_buildbot_config 04:26:13 INFO - Using buildbot properties: 04:26:13 INFO - { 04:26:13 INFO - "properties": { 04:26:13 INFO - "buildnumber": 775, 04:26:13 INFO - "product": "firefox", 04:26:13 INFO - "script_repo_revision": "production", 04:26:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:26:13 INFO - "repository": "", 04:26:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:26:13 INFO - "buildid": "20151127103731", 04:26:13 INFO - "slavename": "talos-linux64-ix-023", 04:26:13 INFO - "pgo_build": "False", 04:26:13 INFO - "basedir": "/builds/slave/test", 04:26:13 INFO - "project": "", 04:26:13 INFO - "platform": "ubuntu64_hw", 04:26:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:26:13 INFO - "slavebuilddir": "test", 04:26:13 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:26:13 INFO - "branch": "fx-team", 04:26:13 INFO - "repo_path": "integration/fx-team", 04:26:13 INFO - "stage_platform": "linux64", 04:26:13 INFO - "builduid": "3f081eb818b04624a3a075611ac903f2", 04:26:13 INFO - "revision": "f48352b311eb120a09347efce60ae9045401858c" 04:26:13 INFO - }, 04:26:13 INFO - "sourcestamp": { 04:26:13 INFO - "repository": "", 04:26:13 INFO - "hasPatch": false, 04:26:13 INFO - "project": "", 04:26:13 INFO - "branch": "fx-team-linux64-talos", 04:26:13 INFO - "changes": [ 04:26:13 INFO - { 04:26:13 INFO - "category": null, 04:26:13 INFO - "files": [ 04:26:13 INFO - { 04:26:13 INFO - "url": null, 04:26:13 INFO - "name": "https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:26:13 INFO - } 04:26:13 INFO - ], 04:26:13 INFO - "repository": "", 04:26:13 INFO - "rev": "f48352b311eb120a09347efce60ae9045401858c", 04:26:13 INFO - "who": "mbanner@mozilla.com", 04:26:13 INFO - "when": 1448651775, 04:26:13 INFO - "number": 6715644, 04:26:13 INFO - "comments": "Backout changeset 958669938c10 / bug 1225832 due to frequent mochitest failures on Mac", 04:26:13 INFO - "project": "", 04:26:13 INFO - "at": "Fri 27 Nov 2015 11:16:15", 04:26:13 INFO - "branch": "fx-team-linux64-talos", 04:26:13 INFO - "revlink": "", 04:26:13 INFO - "properties": [ 04:26:13 INFO - [ 04:26:13 INFO - "buildid", 04:26:13 INFO - "20151127103731", 04:26:13 INFO - "Change" 04:26:13 INFO - ], 04:26:13 INFO - [ 04:26:13 INFO - "builduid", 04:26:13 INFO - "3f081eb818b04624a3a075611ac903f2", 04:26:13 INFO - "Change" 04:26:13 INFO - ], 04:26:13 INFO - [ 04:26:13 INFO - "pgo_build", 04:26:13 INFO - "False", 04:26:13 INFO - "Change" 04:26:13 INFO - ] 04:26:13 INFO - ], 04:26:13 INFO - "revision": "f48352b311eb120a09347efce60ae9045401858c" 04:26:13 INFO - } 04:26:13 INFO - ], 04:26:13 INFO - "revision": "f48352b311eb120a09347efce60ae9045401858c" 04:26:13 INFO - } 04:26:13 INFO - } 04:26:13 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:13 INFO - Running post-action listener: _resource_record_post_action 04:26:13 INFO - ##### 04:26:13 INFO - ##### Running download-and-extract step. 04:26:13 INFO - ##### 04:26:13 INFO - Running pre-action listener: _resource_record_pre_action 04:26:13 INFO - Running main action method: download_and_extract 04:26:13 INFO - mkdir: /builds/slave/test/build/tests 04:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:13 INFO - https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:26:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/test_packages.json 04:26:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/test_packages.json 04:26:13 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:13 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:14 INFO - Downloaded 1302 bytes. 04:26:14 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:26:14 INFO - Using the following test package requirements: 04:26:14 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:14 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:14 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:26:14 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:14 INFO - u'jsshell-linux-x86_64.zip'], 04:26:14 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:14 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:26:14 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:14 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:14 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:26:14 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:14 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:26:14 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:14 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:26:14 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:14 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:14 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:26:14 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:14 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:14 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:14 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:14 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:14 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:15 INFO - Downloaded 21517181 bytes. 04:26:15 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:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:26:15 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:16 INFO - Return code: 0 04:26:16 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:16 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:16 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:16 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:16 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:16 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:16 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:18 INFO - Downloaded 21517181 bytes. 04:26:18 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:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:26:18 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:19 INFO - Return code: 0 04:26:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:19 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:19 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:19 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:19 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:19 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:21 INFO - Downloaded 11131728 bytes. 04:26:21 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:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:26:21 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:21 INFO - Return code: 0 04:26:21 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:21 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:21 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:21 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:21 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:21 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:23 INFO - Downloaded 56872327 bytes. 04:26:23 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:23 INFO - mkdir: /builds/slave/test/properties 04:26:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:26:23 INFO - Writing to file /builds/slave/test/properties/build_url 04:26:23 INFO - Contents: 04:26:23 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:23 INFO - Running post-action listener: _resource_record_post_action 04:26:23 INFO - Running post-action listener: set_extra_try_arguments 04:26:23 INFO - ##### 04:26:23 INFO - ##### Running populate-webroot step. 04:26:23 INFO - ##### 04:26:23 INFO - Running pre-action listener: _resource_record_pre_action 04:26:23 INFO - Running main action method: populate_webroot 04:26:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:26:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:26:23 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:26:23 INFO - '../fennec_ids.txt'], 04:26:23 INFO - 'tests': ['tcheck2']}, 04:26:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:26:23 INFO - '--tppagecycles', 04:26:23 INFO - '7'], 04:26:23 INFO - 'tests': ['tsvgm']}}, 04:26:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:26:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:26:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:26:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:26:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:26:23 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:26:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:23 INFO - 'talos_options': ['--e10s'], 04:26:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:23 INFO - 'tests': ['damp', 'tps']}, 04:26:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:23 INFO - 'talos_options': ['--e10s'], 04:26:23 INFO - 'tests': ['damp', 'tps']}, 04:26:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:26:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:26:23 INFO - 'other': {'tests': ['a11yr', 04:26:23 INFO - 'ts_paint', 04:26:23 INFO - 'tpaint', 04:26:23 INFO - 'sessionrestore', 04:26:23 INFO - 'sessionrestore_no_auto_restore']}, 04:26:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:26:23 INFO - 'tests': ['a11yr', 04:26:23 INFO - 'ts_paint', 04:26:23 INFO - 'tpaint', 04:26:23 INFO - 'sessionrestore', 04:26:23 INFO - 'sessionrestore_no_auto_restore']}, 04:26:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:26:23 INFO - 'tests': ['a11yr', 04:26:23 INFO - 'ts_paint', 04:26:23 INFO - 'tpaint', 04:26:23 INFO - 'sessionrestore', 04:26:23 INFO - 'sessionrestore_no_auto_restore']}, 04:26:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:26:23 INFO - 'tests': ['a11yr', 04:26:23 INFO - 'ts_paint', 04:26:23 INFO - 'tpaint', 04:26:23 INFO - 'sessionrestore', 04:26:23 INFO - 'sessionrestore_no_auto_restore']}, 04:26:23 INFO - 'other_l64': {'tests': ['a11yr', 04:26:23 INFO - 'ts_paint', 04:26:23 INFO - 'tpaint', 04:26:23 INFO - 'sessionrestore', 04:26:23 INFO - 'sessionrestore_no_auto_restore']}, 04:26:23 INFO - 'other_nol64': {'tests': ['a11yr', 04:26:23 INFO - 'ts_paint', 04:26:23 INFO - 'tpaint', 04:26:23 INFO - 'sessionrestore', 04:26:23 INFO - 'sessionrestore_no_auto_restore']}, 04:26:23 INFO - 'svgr': {'tests': ['tsvgx', 04:26:23 INFO - 'tsvgr_opacity', 04:26:23 INFO - 'tart', 04:26:23 INFO - 'tscrollx', 04:26:23 INFO - 'cart']}, 04:26:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:26:23 INFO - 'tests': ['tsvgx', 04:26:23 INFO - 'tsvgr_opacity', 04:26:23 INFO - 'tart', 04:26:23 INFO - 'tscrollx', 04:26:23 INFO - 'cart']}, 04:26:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:23 INFO - 'tests': ['tp5o']}, 04:26:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:23 INFO - 'talos_options': ['--e10s'], 04:26:23 INFO - 'tests': ['tp5o']}, 04:26:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:23 INFO - 'talos_options': ['--xperf_path', 04:26:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:23 INFO - 'tests': ['tp5n']}, 04:26:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:23 INFO - 'talos_options': ['--e10s', 04:26:23 INFO - '--xperf_path', 04:26:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:23 INFO - 'tests': ['tp5n']}}, 04:26:23 INFO - 'talos.zip': {'path': '', 04:26:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:26:23 INFO - Running post-action listener: _resource_record_post_action 04:26:23 INFO - ##### 04:26:23 INFO - ##### Running create-virtualenv step. 04:26:23 INFO - ##### 04:26:23 INFO - Running pre-action listener: _resource_record_pre_action 04:26:23 INFO - Running main action method: create_virtualenv 04:26:23 INFO - Creating virtualenv /builds/slave/test/build/venv 04:26:23 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:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:26:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:26:24 INFO - Using real prefix '/usr' 04:26:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:26:24 INFO - Installing distribute.............................................................................................................................................................................................done. 04:26:26 INFO - Installing pip.................done. 04:26:26 INFO - Return code: 0 04:26:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:26:26 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:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:26 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:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:26 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 0x7f4cb0263f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1665240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f40b0>, '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 0x16f4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5440>, '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': 'e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626', '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:26 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:26 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:26 INFO - Using env: {'DISPLAY': ':0', 04:26:26 INFO - 'HOME': '/home/cltbld', 04:26:26 INFO - 'LANG': 'en_US.UTF-8', 04:26:26 INFO - 'LANGUAGE': 'en_US:en', 04:26:26 INFO - 'LOGNAME': 'cltbld', 04:26:26 INFO - 'MAIL': '/var/mail/cltbld', 04:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:26 INFO - 'MOZ_NO_REMOTE': '1', 04:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:26 INFO - 'NO_EM_RESTART': '1', 04:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:26 INFO - 'PWD': '/builds/slave/test', 04:26:26 INFO - 'SHELL': '/bin/bash', 04:26:26 INFO - 'SHLVL': '1', 04:26:26 INFO - 'TERM': 'linux', 04:26:26 INFO - 'TMOUT': '86400', 04:26:26 INFO - 'USER': 'cltbld', 04:26:26 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626', 04:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:26 INFO - '_': '/tools/buildbot/bin/python'} 04:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:26 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:26 INFO - Cleaning up... 04:26:26 INFO - Return code: 0 04:26:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:26:26 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:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:26 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:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:26 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 0x7f4cb0263f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1665240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f40b0>, '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 0x16f4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5440>, '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': 'e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626', '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:26 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:26 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:26 INFO - Using env: {'DISPLAY': ':0', 04:26:26 INFO - 'HOME': '/home/cltbld', 04:26:26 INFO - 'LANG': 'en_US.UTF-8', 04:26:26 INFO - 'LANGUAGE': 'en_US:en', 04:26:26 INFO - 'LOGNAME': 'cltbld', 04:26:26 INFO - 'MAIL': '/var/mail/cltbld', 04:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:26 INFO - 'MOZ_NO_REMOTE': '1', 04:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:26 INFO - 'NO_EM_RESTART': '1', 04:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:26 INFO - 'PWD': '/builds/slave/test', 04:26:26 INFO - 'SHELL': '/bin/bash', 04:26:26 INFO - 'SHLVL': '1', 04:26:26 INFO - 'TERM': 'linux', 04:26:26 INFO - 'TMOUT': '86400', 04:26:26 INFO - 'USER': 'cltbld', 04:26:26 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626', 04:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:26 INFO - '_': '/tools/buildbot/bin/python'} 04:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:26 INFO - Downloading/unpacking psutil>=0.7.1 04:26:26 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:26 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:26 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:26 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:26 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:26 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 - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:26:28 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:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:26:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:26:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:26:28 INFO - Installing collected packages: psutil 04:26:28 INFO - Running setup.py install for psutil 04:26:28 INFO - building 'psutil._psutil_linux' extension 04:26:28 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:28 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:29 INFO - building 'psutil._psutil_posix' extension 04:26:29 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:29 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:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:26:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:26:29 INFO - Successfully installed psutil 04:26:29 INFO - Cleaning up... 04:26:29 INFO - Return code: 0 04:26:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:29 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 0x7f4cb0263f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1665240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f40b0>, '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 0x16f4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5440>, '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': 'e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626', '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:29 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:29 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:29 INFO - Using env: {'DISPLAY': ':0', 04:26:29 INFO - 'HOME': '/home/cltbld', 04:26:29 INFO - 'LANG': 'en_US.UTF-8', 04:26:29 INFO - 'LANGUAGE': 'en_US:en', 04:26:29 INFO - 'LOGNAME': 'cltbld', 04:26:29 INFO - 'MAIL': '/var/mail/cltbld', 04:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:29 INFO - 'MOZ_NO_REMOTE': '1', 04:26:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:29 INFO - 'NO_EM_RESTART': '1', 04:26:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:29 INFO - 'PWD': '/builds/slave/test', 04:26:29 INFO - 'SHELL': '/bin/bash', 04:26:29 INFO - 'SHLVL': '1', 04:26:29 INFO - 'TERM': 'linux', 04:26:29 INFO - 'TMOUT': '86400', 04:26:29 INFO - 'USER': 'cltbld', 04:26:29 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626', 04:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:29 INFO - '_': '/tools/buildbot/bin/python'} 04:26:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 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:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:26:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:26:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:26:31 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:31 INFO - Installing collected packages: mozsystemmonitor 04:26:31 INFO - Running setup.py install for mozsystemmonitor 04:26:31 INFO - Successfully installed mozsystemmonitor 04:26:31 INFO - Cleaning up... 04:26:31 INFO - Return code: 0 04:26:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:26:31 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:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:31 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:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:31 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 0x7f4cb0263f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1665240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f40b0>, '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 0x16f4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5440>, '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': 'e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626', '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:31 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:31 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:31 INFO - Using env: {'DISPLAY': ':0', 04:26:31 INFO - 'HOME': '/home/cltbld', 04:26:31 INFO - 'LANG': 'en_US.UTF-8', 04:26:31 INFO - 'LANGUAGE': 'en_US:en', 04:26:31 INFO - 'LOGNAME': 'cltbld', 04:26:31 INFO - 'MAIL': '/var/mail/cltbld', 04:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:31 INFO - 'MOZ_NO_REMOTE': '1', 04:26:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:31 INFO - 'NO_EM_RESTART': '1', 04:26:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:31 INFO - 'PWD': '/builds/slave/test', 04:26:31 INFO - 'SHELL': '/bin/bash', 04:26:31 INFO - 'SHLVL': '1', 04:26:31 INFO - 'TERM': 'linux', 04:26:31 INFO - 'TMOUT': '86400', 04:26:31 INFO - 'USER': 'cltbld', 04:26:31 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626', 04:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:31 INFO - '_': '/tools/buildbot/bin/python'} 04:26:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:31 INFO - Downloading/unpacking blobuploader==1.2.4 04:26:31 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:31 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:31 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:31 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:31 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:31 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:33 INFO - Downloading blobuploader-1.2.4.tar.gz 04:26:33 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:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:26:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:26:33 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:33 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:33 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:33 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:33 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:33 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:33 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:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:26:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:26:33 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:33 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:33 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:33 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:33 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:33 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:33 INFO - Downloading docopt-0.6.1.tar.gz 04:26:33 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:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:26:33 INFO - Installing collected packages: blobuploader, requests, docopt 04:26:33 INFO - Running setup.py install for blobuploader 04:26:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:26:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:26:34 INFO - Running setup.py install for requests 04:26:34 INFO - Running setup.py install for docopt 04:26:34 INFO - Successfully installed blobuploader requests docopt 04:26:34 INFO - Cleaning up... 04:26:34 INFO - Return code: 0 04:26:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:34 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:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:34 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:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:34 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 0x7f4cb0263f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1665240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f40b0>, '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 0x16f4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5440>, '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': 'e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626', '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:34 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:34 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:34 INFO - Using env: {'DISPLAY': ':0', 04:26:34 INFO - 'HOME': '/home/cltbld', 04:26:34 INFO - 'LANG': 'en_US.UTF-8', 04:26:34 INFO - 'LANGUAGE': 'en_US:en', 04:26:34 INFO - 'LOGNAME': 'cltbld', 04:26:34 INFO - 'MAIL': '/var/mail/cltbld', 04:26:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:34 INFO - 'MOZ_NO_REMOTE': '1', 04:26:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:34 INFO - 'NO_EM_RESTART': '1', 04:26:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:34 INFO - 'PWD': '/builds/slave/test', 04:26:34 INFO - 'SHELL': '/bin/bash', 04:26:34 INFO - 'SHLVL': '1', 04:26:34 INFO - 'TERM': 'linux', 04:26:34 INFO - 'TMOUT': '86400', 04:26:34 INFO - 'USER': 'cltbld', 04:26:34 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626', 04:26:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:34 INFO - '_': '/tools/buildbot/bin/python'} 04:26:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:26:34 INFO - Running setup.py (path:/tmp/pip-eUDwdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:26:34 INFO - Running setup.py (path:/tmp/pip-G0b7WM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:26:34 INFO - Running setup.py (path:/tmp/pip-e5ulYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:26:35 INFO - Running setup.py (path:/tmp/pip-d_t4lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:26:35 INFO - Running setup.py (path:/tmp/pip-gILuwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:26:35 INFO - Running setup.py (path:/tmp/pip-K5Lwni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:26:35 INFO - Running setup.py (path:/tmp/pip-A3JxbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:26:35 INFO - Running setup.py (path:/tmp/pip-tUZW2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:26:35 INFO - Running setup.py (path:/tmp/pip-xJ0jMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:35 INFO - Running setup.py (path:/tmp/pip-PR_2B7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:35 INFO - Running setup.py (path:/tmp/pip-JSNX_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:35 INFO - Running setup.py (path:/tmp/pip-EDJEWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:35 INFO - Running setup.py (path:/tmp/pip-PPwkz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:35 INFO - Running setup.py (path:/tmp/pip-a2jBrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:35 INFO - Running setup.py (path:/tmp/pip-RM6wvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:35 INFO - Running setup.py (path:/tmp/pip-FMzT6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:35 INFO - Running setup.py (path:/tmp/pip-0T6OgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:26:36 INFO - Running setup.py install for manifestparser 04:26:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:26:36 INFO - Running setup.py install for mozcrash 04:26:36 INFO - Running setup.py install for mozdebug 04:26:36 INFO - Running setup.py install for mozdevice 04:26:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:26:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:26:36 INFO - Running setup.py install for mozfile 04:26:36 INFO - Running setup.py install for mozhttpd 04:26:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:26:36 INFO - Running setup.py install for mozinfo 04:26:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:26:36 INFO - Running setup.py install for mozInstall 04:26:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:26:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:26:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:26:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:26:36 INFO - Running setup.py install for mozleak 04:26:36 INFO - Running setup.py install for mozlog 04:26:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:26:37 INFO - Running setup.py install for moznetwork 04:26:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:26:37 INFO - Running setup.py install for mozprocess 04:26:37 INFO - Running setup.py install for mozprofile 04:26:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:26:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:26:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:26:37 INFO - Running setup.py install for mozrunner 04:26:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:26:37 INFO - Running setup.py install for mozscreenshot 04:26:37 INFO - Running setup.py install for moztest 04:26:37 INFO - Running setup.py install for mozversion 04:26:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:26:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:26:37 INFO - Cleaning up... 04:26:37 INFO - Return code: 0 04:26:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:37 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 0x7f4cb0263f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1665240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f40b0>, '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 0x16f4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5440>, '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': 'e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626', '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:37 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:37 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:37 INFO - Using env: {'DISPLAY': ':0', 04:26:37 INFO - 'HOME': '/home/cltbld', 04:26:37 INFO - 'LANG': 'en_US.UTF-8', 04:26:37 INFO - 'LANGUAGE': 'en_US:en', 04:26:37 INFO - 'LOGNAME': 'cltbld', 04:26:37 INFO - 'MAIL': '/var/mail/cltbld', 04:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:37 INFO - 'MOZ_NO_REMOTE': '1', 04:26:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:37 INFO - 'NO_EM_RESTART': '1', 04:26:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:37 INFO - 'PWD': '/builds/slave/test', 04:26:37 INFO - 'SHELL': '/bin/bash', 04:26:37 INFO - 'SHLVL': '1', 04:26:37 INFO - 'TERM': 'linux', 04:26:37 INFO - 'TMOUT': '86400', 04:26:37 INFO - 'USER': 'cltbld', 04:26:37 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626', 04:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:37 INFO - '_': '/tools/buildbot/bin/python'} 04:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:26:38 INFO - Running setup.py (path:/tmp/pip-rWYfOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:26:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:26:38 INFO - Running setup.py (path:/tmp/pip-jdLhaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:26:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:26:38 INFO - Running setup.py (path:/tmp/pip-VIMBhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:26:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:26:38 INFO - Running setup.py (path:/tmp/pip-HcF3Ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:26:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:26:38 INFO - Running setup.py (path:/tmp/pip-_afaAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:26:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:26:38 INFO - Running setup.py (path:/tmp/pip-M7BrWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:26:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:26:38 INFO - Running setup.py (path:/tmp/pip-oWMNe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:26:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:26:38 INFO - Running setup.py (path:/tmp/pip-xN86sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:26:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:26:38 INFO - Running setup.py (path:/tmp/pip-9h8i9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:38 INFO - Running setup.py (path:/tmp/pip-MMiIJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:38 INFO - Running setup.py (path:/tmp/pip-Jk4NtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:38 INFO - Running setup.py (path:/tmp/pip-YPdmXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:38 INFO - Running setup.py (path:/tmp/pip-iyv6ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:38 INFO - Running setup.py (path:/tmp/pip-v56Fv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:39 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:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:39 INFO - Running setup.py (path:/tmp/pip-gy2KUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:39 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:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:39 INFO - Running setup.py (path:/tmp/pip-WUqNAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:39 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:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:39 INFO - Running setup.py (path:/tmp/pip-0jeNhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26:39 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:39 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:39 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:39 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:39 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:39 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:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:26:39 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:39 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:39 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:39 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:39 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:39 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:40 INFO - Downloading blessings-1.5.1.tar.gz 04:26:40 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:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:26:41 INFO - Installing collected packages: blessings 04:26:41 INFO - Running setup.py install for blessings 04:26:41 INFO - Successfully installed blessings 04:26:41 INFO - Cleaning up... 04:26:41 INFO - Return code: 0 04:26:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:26:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:41 INFO - Reading from file tmpfile_stdout 04:26:41 INFO - Current package versions: 04:26:41 INFO - argparse == 1.2.1 04:26:41 INFO - blessings == 1.5.1 04:26:41 INFO - blobuploader == 1.2.4 04:26:41 INFO - docopt == 0.6.1 04:26:41 INFO - manifestparser == 1.1 04:26:41 INFO - mozInstall == 1.12 04:26:41 INFO - mozcrash == 0.16 04:26:41 INFO - mozdebug == 0.1 04:26:41 INFO - mozdevice == 0.47 04:26:41 INFO - mozfile == 1.2 04:26:41 INFO - mozhttpd == 0.7 04:26:41 INFO - mozinfo == 0.9 04:26:41 INFO - mozleak == 0.1 04:26:41 INFO - mozlog == 3.1 04:26:41 INFO - moznetwork == 0.27 04:26:41 INFO - mozprocess == 0.22 04:26:41 INFO - mozprofile == 0.27 04:26:41 INFO - mozrunner == 6.11 04:26:41 INFO - mozscreenshot == 0.1 04:26:41 INFO - mozsystemmonitor == 0.0 04:26:41 INFO - moztest == 0.7 04:26:41 INFO - mozversion == 1.4 04:26:41 INFO - psutil == 3.1.1 04:26:41 INFO - requests == 1.2.3 04:26:41 INFO - wsgiref == 0.1.2 04:26:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:41 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:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:41 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:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:41 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 0x7f4cb0263f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1665240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f40b0>, '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 0x16f4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5440>, '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': 'e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626', '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:41 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:41 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:41 INFO - Using env: {'DISPLAY': ':0', 04:26:41 INFO - 'HOME': '/home/cltbld', 04:26:41 INFO - 'LANG': 'en_US.UTF-8', 04:26:41 INFO - 'LANGUAGE': 'en_US:en', 04:26:41 INFO - 'LOGNAME': 'cltbld', 04:26:41 INFO - 'MAIL': '/var/mail/cltbld', 04:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:41 INFO - 'MOZ_NO_REMOTE': '1', 04:26:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:41 INFO - 'NO_EM_RESTART': '1', 04:26:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:41 INFO - 'PWD': '/builds/slave/test', 04:26:41 INFO - 'SHELL': '/bin/bash', 04:26:41 INFO - 'SHLVL': '1', 04:26:41 INFO - 'TERM': 'linux', 04:26:41 INFO - 'TMOUT': '86400', 04:26:41 INFO - 'USER': 'cltbld', 04:26:41 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626', 04:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:41 INFO - '_': '/tools/buildbot/bin/python'} 04:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 INFO - Cleaning up... 04:26:41 INFO - Return code: 0 04:26:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:26:41 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:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:41 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:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:41 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 0x7f4cb0263f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1665240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f40b0>, '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 0x16f4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5440>, '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': 'e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626', '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:41 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:41 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:41 INFO - Using env: {'DISPLAY': ':0', 04:26:41 INFO - 'HOME': '/home/cltbld', 04:26:41 INFO - 'LANG': 'en_US.UTF-8', 04:26:41 INFO - 'LANGUAGE': 'en_US:en', 04:26:41 INFO - 'LOGNAME': 'cltbld', 04:26:41 INFO - 'MAIL': '/var/mail/cltbld', 04:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:41 INFO - 'MOZ_NO_REMOTE': '1', 04:26:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:41 INFO - 'NO_EM_RESTART': '1', 04:26:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:41 INFO - 'PWD': '/builds/slave/test', 04:26:41 INFO - 'SHELL': '/bin/bash', 04:26:41 INFO - 'SHLVL': '1', 04:26:41 INFO - 'TERM': 'linux', 04:26:41 INFO - 'TMOUT': '86400', 04:26:41 INFO - 'USER': 'cltbld', 04:26:41 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626', 04:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:41 INFO - '_': '/tools/buildbot/bin/python'} 04:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:41 INFO - Downloading/unpacking jsonschema 04:26:41 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:41 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:41 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:41 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:41 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:41 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:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:26:43 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:43 INFO - Downloading/unpacking functools32 (from jsonschema) 04:26:43 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:43 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:43 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:43 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:43 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:43 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:43 INFO - Downloading functools32-3.2.3-2.tar.gz 04:26:44 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:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:26:44 INFO - warning: no files found matching '*.txt' 04:26:44 INFO - no previously-included directories found matching 'build' 04:26:44 INFO - no previously-included directories found matching 'dist' 04:26:44 INFO - no previously-included directories found matching '.git*' 04:26:44 INFO - Installing collected packages: jsonschema, functools32 04:26:44 INFO - Running setup.py install for functools32 04:26:44 INFO - warning: no files found matching '*.txt' 04:26:44 INFO - no previously-included directories found matching 'build' 04:26:44 INFO - no previously-included directories found matching 'dist' 04:26:44 INFO - no previously-included directories found matching '.git*' 04:26:44 INFO - Successfully installed jsonschema functools32 04:26:44 INFO - Cleaning up... 04:26:44 INFO - Return code: 0 04:26:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:26:44 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:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:44 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:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:44 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 0x7f4cb0263f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1665240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f40b0>, '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 0x16f4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5440>, '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': 'e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626', '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:44 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:44 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:44 INFO - Using env: {'DISPLAY': ':0', 04:26:44 INFO - 'HOME': '/home/cltbld', 04:26:44 INFO - 'LANG': 'en_US.UTF-8', 04:26:44 INFO - 'LANGUAGE': 'en_US:en', 04:26:44 INFO - 'LOGNAME': 'cltbld', 04:26:44 INFO - 'MAIL': '/var/mail/cltbld', 04:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:44 INFO - 'MOZ_NO_REMOTE': '1', 04:26:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:44 INFO - 'NO_EM_RESTART': '1', 04:26:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:44 INFO - 'PWD': '/builds/slave/test', 04:26:44 INFO - 'SHELL': '/bin/bash', 04:26:44 INFO - 'SHLVL': '1', 04:26:44 INFO - 'TERM': 'linux', 04:26:44 INFO - 'TMOUT': '86400', 04:26:44 INFO - 'USER': 'cltbld', 04:26:44 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626', 04:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:44 INFO - '_': '/tools/buildbot/bin/python'} 04:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:44 INFO - Downloading/unpacking flake8 04:26:44 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:44 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:44 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:44 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:44 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:44 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:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:26:46 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:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:26:46 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:46 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:46 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:46 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:46 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:46 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:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:26:46 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:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:26:46 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:46 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:46 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:46 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:46 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:46 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:46 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:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:26:46 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:46 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:46 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:46 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:46 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:46 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:47 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:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:26:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:26:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:26:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:26:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:26:47 INFO - no previously-included directories found matching 'docs/_build' 04:26:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:26:47 INFO - Running setup.py install for pep8 04:26:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:26:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:26:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:26:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:26:47 INFO - no previously-included directories found matching 'docs/_build' 04:26:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:26:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:26:47 INFO - Cleaning up... 04:26:47 INFO - Return code: 0 04:26:47 INFO - Running post-action listener: _resource_record_post_action 04:26:47 INFO - Running post-action listener: _start_resource_monitoring 04:26:47 INFO - Starting resource monitoring. 04:26:47 INFO - ##### 04:26:47 INFO - ##### Running install 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: install 04:26:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:47 INFO - Reading from file tmpfile_stdout 04:26:47 INFO - Detecting whether we're running mozinstall >=1.0... 04:26:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:26:47 INFO - Reading from file tmpfile_stdout 04:26:47 INFO - Output received: 04:26:47 INFO - Usage: mozinstall [options] installer 04:26:47 INFO - Options: 04:26:47 INFO - -h, --help show this help message and exit 04:26:47 INFO - -d DEST, --destination=DEST 04:26:47 INFO - Directory to install application into. [default: 04:26:47 INFO - "/builds/slave/test"] 04:26:47 INFO - --app=APP Application being installed. [default: firefox] 04:26:47 INFO - mkdir: /builds/slave/test/build/application 04:26:47 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:47 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:27:02 INFO - Reading from file tmpfile_stdout 04:27:02 INFO - Output received: 04:27:02 INFO - /builds/slave/test/build/application/firefox/firefox 04:27:02 INFO - Running post-action listener: _resource_record_post_action 04:27:02 INFO - ##### 04:27:02 INFO - ##### Running run-tests step. 04:27:02 INFO - ##### 04:27:02 INFO - Running pre-action listener: _resource_record_pre_action 04:27:02 INFO - Running main action method: run_tests 04:27:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:27:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:27:02 INFO - Python 2.7.3 04:27:02 INFO - Return code: 0 04:27:02 INFO - grabbing minidump binary from tooltool 04:27: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:27:02 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 0x16f40b0>, '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 0x16f4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:27:02 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:27:02 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:27:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:27:02 INFO - Return code: 0 04:27:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:27:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:27:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:27:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:27:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:27:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:27:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:27:03 INFO - Return code: 0 04:27:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] in /builds/slave/test/build 04:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost 04:27:03 INFO - Using env: {'DISPLAY': ':0', 04:27:03 INFO - 'HOME': '/home/cltbld', 04:27:03 INFO - 'LANG': 'en_US.UTF-8', 04:27:03 INFO - 'LANGUAGE': 'en_US:en', 04:27:03 INFO - 'LOGNAME': 'cltbld', 04:27:03 INFO - 'MAIL': '/var/mail/cltbld', 04:27:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:27:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:03 INFO - 'MOZ_NO_REMOTE': '1', 04:27:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:27:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:03 INFO - 'NO_EM_RESTART': '1', 04:27:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:03 INFO - 'PWD': '/builds/slave/test', 04:27:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:27:03 INFO - 'SHELL': '/bin/bash', 04:27:03 INFO - 'SHLVL': '1', 04:27:03 INFO - 'TERM': 'linux', 04:27:03 INFO - 'TMOUT': '86400', 04:27:03 INFO - 'USER': 'cltbld', 04:27:03 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626', 04:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:03 INFO - '_': '/tools/buildbot/bin/python'} 04:27:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] with output_timeout 3600 04:27:03 INFO - mozversion INFO | application_buildid: 20151127103731 04:27:03 INFO - mozversion INFO | application_changeset: f48352b311eb120a09347efce60ae9045401858c 04:27:03 INFO - mozversion INFO | application_display_name: Nightly 04:27:03 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:27:03 INFO - mozversion INFO | application_name: Firefox 04:27:03 INFO - mozversion INFO | application_remotingname: firefox 04:27:03 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:27:03 INFO - mozversion INFO | application_vendor: Mozilla 04:27:03 INFO - mozversion INFO | application_version: 45.0a1 04:27:03 INFO - mozversion INFO | platform_buildid: 20151127103731 04:27:03 INFO - mozversion INFO | platform_changeset: f48352b311eb120a09347efce60ae9045401858c 04:27:03 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:27:03 INFO - mozversion INFO | platform_version: 45.0a1 04:27:03 INFO - 2015-12-02 04:27:03,235 DEBUG : using testdate: 1449059223 04:27:03 INFO - 2015-12-02 04:27:03,236 DEBUG : actual date: 1449059223 04:27:03 INFO - 2015-12-02 04:27:03,245 INFO : starting webserver on 'localhost:48490' 04:27:03 INFO - 2015-12-02 04:27:03,246 INFO : Starting test suite talos-linux64-ix-023.e 04:27:03 INFO - 2015-12-02 04:27:03,247 INFO : Starting test dromaeo_css 04:27:03 INFO - 2015-12-02 04:27:03,247 DEBUG : operating with platform_type : linux_ 04:27:03 INFO - 2015-12-02 04:27:03,247 INFO : Initialising browser for dromaeo_css test... 04:27:03 INFO - 2015-12-02 04:27:03,260 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ1s_bg/profile http://localhost:48490/getInfo.html 04:27:08 INFO - 2015-12-02 04:27:08,173 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:27:08 INFO - 2015-12-02 04:27:08,174 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:27:08 INFO - 2015-12-02 04:27:08,174 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:27:08 INFO - 2015-12-02 04:27:08,174 DEBUG : BROWSER_OUTPUT: __metrics 04:27:09 INFO - 2015-12-02 04:27:09,357 INFO : Browser initialized. 04:27:09 INFO - 2015-12-02 04:27:09,358 INFO : Running cycle 1/1 for dromaeo_css test... 04:27:09 INFO - 2015-12-02 04:27:09,358 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ1s_bg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:27:21 INFO - 2015-12-02 04:27:21,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 138850304 04:27:21 INFO - 2015-12-02 04:27:21,224 DEBUG : BROWSER_OUTPUT: 04:28:10 INFO - 2015-12-02 04:28:10,890 DEBUG : BROWSER_OUTPUT: 1449059290888 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:22 INFO - 2015-12-02 04:30:22,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48490/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48490/tests/dromaeo/cssquery-ext.html) 04:30:23 INFO - 2015-12-02 04:30:23,572 DEBUG : BROWSER_OUTPUT: RSS: Main: 144752640 04:30:23 INFO - 2015-12-02 04:30:23,572 DEBUG : BROWSER_OUTPUT: 04:33:25 INFO - 2015-12-02 04:33:25,597 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48490/tests/dromaeo/cssquery-ext.html (next: http://localhost:48490/tests/dromaeo/cssquery-jquery.html) 04:33:26 INFO - 2015-12-02 04:33:26,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 142135296 04:33:26 INFO - 2015-12-02 04:33:26,200 DEBUG : BROWSER_OUTPUT: 04:36:27 INFO - 2015-12-02 04:36:27,958 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48490/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48490/tests/dromaeo/cssquery-mootools.html) 04:36:28 INFO - 2015-12-02 04:36:28,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 143458304 04:36:28 INFO - 2015-12-02 04:36:28,560 DEBUG : BROWSER_OUTPUT: 04:39:30 INFO - 2015-12-02 04:39:30,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48490/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48490/tests/dromaeo/cssquery-prototype.html) 04:39:30 INFO - 2015-12-02 04:39:30,964 DEBUG : BROWSER_OUTPUT: RSS: Main: 141651968 04:39:30 INFO - 2015-12-02 04:39:30,965 DEBUG : BROWSER_OUTPUT: 04:42:33 INFO - 2015-12-02 04:42:33,504 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48490/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48490/tests/dromaeo/cssquery-yui.html) 04:42:34 INFO - 2015-12-02 04:42:34,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 142614528 04:42:34 INFO - 2015-12-02 04:42:34,131 DEBUG : BROWSER_OUTPUT: 04:45:36 INFO - 2015-12-02 04:45:36,412 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48490/tests/dromaeo/cssquery-yui.html (next: http://localhost:48490/tests/dromaeo/cssquery-dojo.html) 04:45:36 INFO - 2015-12-02 04:45:36,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 144486400 04:45:36 INFO - 2015-12-02 04:45:36,670 DEBUG : BROWSER_OUTPUT: 04:45:36 INFO - 2015-12-02 04:45:36,671 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:45:36 INFO - 2015-12-02 04:45:36,671 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:45:36 INFO - 2015-12-02 04:45:36,671 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:45:36 INFO - 2015-12-02 04:45:36,671 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:45:36 INFO - 2015-12-02 04:45:36,672 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2632.512985097757;2666.3067602423366;2688.6639170103736;2710.3901622135018;2724.101046654603;4471.888202794924;4635.675502714816;4650.767461626922;4653.906921861565;4719.315699223611;4568.748718820463;4631.16639004979;4652.720836749789;4700.952990470094;4701.48283688794;4257.276263035276;4337.63130133939;4385.254506733863;4387.605115539601;4449.799759010836;4319.740815551077;4342.3052311630145;4371.453568303962;4450.087732014946;4467.994701192222;4135.1729654069;4234.85178018771;4241.066965267636;4319.222539942824;4324.783760811947;4369.169857727022;4373.365861950031;4377.562243775597;4384.495782984965;4387.429634147572;4350.521442641307;4358.564143585648;4365.912681746379;4384.89037774055;4409.338599210144;4400.295952647561;4521.638268938477;4559.794809233593;4624.606908412756;4649.372334734835;5021.673591216596;5035.219540971156;5047.823326183566;5056.342675452168;5104.05574968632;5090.872728181788;5094.770735316883;5098.082345177866;5103.515166059218;5119.129747942859;4501.167284052461;4571;4595.241785105453;4639.884002899887;4687.95312046882;5123.87190320245;5125.051865404912;5125.256837758504;5141.742912854343;5156.1750119980625;4743.691660042086;4942.481039490874;4945.455999840015;4948.4309304429735;4996.200607902718;4928.211486162197;4935.235038569028;4967.180415231519;4995.500449954975;5026.949730502648;4961.90076198474;4977.253411988231;4979.377577802775;4981.726005069683;5027.296178535008;4759.547842954914;4869.415670119608;4959.454460009396;4960.280759289883;5002.674826136289;4158.355454904495;4217.156568686275;4220.430241917364;4222.641075508616;4258.552851950562;3704.5369328833895;3745.5879853216125;3750.624937506282;3777.20678657485;3786.545614526219;4184.769837658958;4265.1469706058915;4265.936010959838;4359.346098085312;4364.54172311909;4897.265410188429;4973.229149481836;5004.524570165829;5034.723090229999;5060.49395060491;4331.480222373272;4338.913221735547;4372.344148377769;4373.956260437355;4400.9559904401185;4483.439570053743;4509.098180363941;4514.751688657156;4517.706349087299;4554.020885509632;4588.082383523309;4631.328457373729;4669.719816811003;4672.883177920511;4693.577578017995;4989.700617962933;5002.674826136289;5004;5020.523050310215;5058.595312375075;4592.609628181508;4757.048590281888;4763.618910487222;4765.76171191446;4810.855674329776;4836.105320515716;4893.486183950777;4923.778429970588;4944.950550494593;4979.253112033224;4971.135824065976;4997;5016.046951079284;5035.496450354935;5079.136546787129;4688.671792974459;4782.497837726988;4862.149123903232;4876.122297986397;4911;4729.929051064168;4798.1843086676045;4811.206150985048;4818.638602104786;4848.878778030577;4730.1958667026;4747.406574178228;4758.357621721162;4766.475687674284;4773.236282194832;4718.7640617969655;4795;4826.034793041476;4896.4124305083615;4914.557689807934;4835.8065677372515;4846.927296090632;4873.51264873524;4886.560209581155;4920.926186107283 04:45:36 INFO - 2015-12-02 04:45:36,672 DEBUG : BROWSER_OUTPUT: |1;ext.html;547.2448021730012;559.9132134519151;568.8862227554488;569.154805114405;576.3717547872818;35802.13582913367;37090;37150;37208.627913720855;37304.44043339349;40036.79981600088;40516.18967620646;40516.39225411621;40752;40798.59201407985;7953.602319883998;8060.798480038016;8063.717769878055;8121.593920303991;8146.429749917508;7836.72571459999;7914.960425197866;7992.760217193493;8028.357731381505;8053.033635963663;7923.247291507298;8022.237887400717;8035.196480351948;8056.07355154156;8062.234087761653;7921.56431396273;8023.237792409712;8028.317593004602;8036.4776289541;8046.316063134641;7897.17079706634;7940;7954.9602251988945;8008.839823203503;8026.598670066532;36826.63173368259;37376.813115934245;37398.8130059348;37403.62596374028;37450.25099498022;2834.5323021701392;2849.7190522796236;2908.287469569969;2963.7925345225844;3017.909462716122;28095;28242.85878570594;28375.858120709472;28479.857600711865;28750.281242968886;3350.5644266245477;3402.557667503209;3451.6720911513366;3454.726802665741;3537.0626783902285;213599;216445.99999999843;217194;217504;218146;51391.74304128456;51712;51786.741066294424;52017.219741703906;52026;57921.42078579245;58107;58262.70868645715;58864.41135588675;58898.11652825211;11461.942690286494;11616.361100139404;11637.88362116385;11639.53441862316;11695.473703683354;8539.871901921477;8541.743747687578;8550.102239264912;8550.914490855012;8567.74296771098;18797.718034229496;19158.13788379526;19276.132574034204;19306.90346548258;19343.516412089528;7597.430192735567;7657.272559106876;7739.993800805859;7792.961035194901;7841.882371764428;860.3418384935529;895.4671970177734;915.231205787142;981.9361741486781;1029.7528593137592;25412.237632871045;25614.359641009123;25674.486510270064;25815.483690326088;25897.741022589533;896.5293221058996;940.5673390240429;1020.7448137965508;1033.8449232615017;1039.2828948025838;13886.375113119933;14290.57128286153;14564;14736.705265894836;14886.627834304229;327350;328981;330739.8093104902;330887;331885;47892;48001;48134.518654813706;48177.75911120422;48205.51794482081;1187.9465424055766;1200.4297958469658;1219.5792451604182;1237.5359240284893;1239.6776838022179;27163;27282.317942051606;27491.86254068717;28125.437491250468;28308.009219677213;40157.77948866629;40157.79921100376;40434.39348409835;40485.59514404936;40511.594884050784;248827;252027;252679;252700;253066;29469.705302947554;41443;41946.16107677768;42696.78651606722;42747.57252427436;38192.23615527618;39011.6098839008;39170;39438.80280598579;40170;33661.15847103842;34128.829355853064;34192.829035855655;34621.30757384788;35367;35664.28671426505;36449.088772780895;36900;37095.44356834596;37328;35075.82462087673;35879.64120358763;36137;36243.09392265109;36741.816290918374;34156.658433415345;34940.82529587336;35635.46546801852;35930.8203458981;36093.819530902176;25007.499850003263;25115.246542603752;25411.491770164863;25426.018132248108;25710.61434078453 04:45:36 INFO - 2015-12-02 04:45:36,672 DEBUG : BROWSER_OUTPUT: |2;jquery.html;310.7467414057543;317.89668357783717;320.220263657993;320.2681871922657;323.8623584976386;14448.277586120692;14934.25328733563;15339.616509587251;15521.534353969399;16382.098984555845;8380.748577542683;8424.873626895585;8434.40959132861;8437.70468033619;8541.4448060876;4335.436393268878;4425.690201685883;4430.26900561407;4447.243968525342;4467.709598876079;4444.577765112325;4456.286994080948;4459.219636563588;6321.273053598826;6433.806985790434;6419.51853610981;6423.614583125004;6426.132472116275;6433.7104830282515;6444.677766111699;6449.290578036413;6683.164604424447;6687.699053542602;6712.5301228913995;6720.798376048726;6125.448709616111;6168.907466388007;6407.391297826699;6430.807075787734;6431.292557818636;20391.184352625878;20735.792642073688;20867.582648346946;20881.26915557948;21202.939853007443;1818.4181062060145;1873.5784448498978;1944.1542928826007;1958.608278344337;1976.6837306030966;13104.672383190402;13184.274864882427;13254.035683942167;13336.933315333457;13859.514916977958;1827.1138497828542;1868;1871.737956686065;1911.8757280776845;1924.201456395594;57535.71232143854;63085.36914630841;65856;66504.3349566503;67216.32783672199;15588.298526566332;15748.448804291795;15782.60543486399;15793.289301981438;15794.131322777128;10659.680209593724;10908.454577271104;23658.171963981178;23703.644445333335;23791.7620823793;6085.300190478151;6229.56393052482;6242.1261023456755;6359;6473.381654586354;5905.261842269716;5915.1718759373725;5994.130851026577;6036.034234522455;6070.726817293233;4024.4566983457444;4027.1140349123148;4030.1939612077704;4032.1330913853662;4048.6356227939627;1436.676747731752;1592.9203539822963;1672.5651330653875;1677.7231756759998;1695.626962068343;831.7338451695521;886.2156991062956;968.8982656821073;969.2682025071026;993.965211217604;15220.467283645019;15252;15802.209889505479;15894.68210635804;16292.837071629132;837.4514692876054;883.650957871637;902.8194361127669;905.6875377994581;940.1585580905188;8904.8664270036;8926.73219803407;9177.03641117673;9294;9294.442333460014;528537;531434;533089;539664;545650;68932.655336723;73786;73799.63100184465;73855.26144738591;74025.25974740292;1024.2267088348249;1082.7996820588216;1134.7276653603242;1141.7316930521322;1146.4095990564865;13537.323133843072;13782.310884455537;13988.230647314496;14197.574072777834;14368.497102601359;31178.22054448657;32268.35463290768;33286.66713332836;33671;33854.492182616785;47138.76430617825;47833.52166478291;50414.2437863425;51750;51928.22107668313;13884.375203115682;14063.156210626987;14316.427342906167;14326.641833954234;14495.637609059437;17089.14554272306;17639.118044098;17681.823181768017;17846.19692113884;17884.55288617795;14153.43386264579;14175.503857364944;14430.639234019234;14874.776878346616;15351.309191086651;13613;14589.781153282496;14599.416023359372;14633.195174265093;15184.544463666107;14071.366788494746;14082.225477598831;14383.640408989859;14710.63223419423;14750.63123421923;13676;13733;13779.517716879862;13872.583822485341;13900.72198556003;14402.279886005448;14685.85314146845;14721.631959201106;14851.480198193012;15063.47277845314 04:45:36 INFO - 2015-12-02 04:45:36,672 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1464.370320762072;1595.6649103688226;1626.3494602159142;1631.4616176661702;1671.2061770658938;6314.116023756677;6367.904481432783;6689.364510371507;6783.864322713549;6787.524873258873;6614.140161778962;6616.206055273362;6692.531522793406;6695.765648202314;6725.630090345029;1927.5759332946764;1931.980680193194;1942.8154325339142;1950.0347328072553;1951.5511432370492;1974.5458544534765;2008.8694234874758;2010.286348346338;2012.3258708332726;2018.5962807438498;1904.5048287445225;1920.2127127877573;1928.151613290155;1972.9112189951486;1972.9901350493228;1942.9417117486498;1968.2815772243027;1969.1335812242567;1969.6356174107837;1971.7239586457908;1947.6883698608297;1988.7514060742408;1988.9602207955759;1995.5310502032012;1995.6308083004546;6568.376004279586;6689.03009063683;6689.264180940093;6691.59850408977;6695.3304669533145;3784.678302344304;3863.961360386388;3864.3816989281863;3873.0317420644838;3884.164904545508;2553.208505363343;2565.563854144781;2599.8180127391092;2638.722934091931;2641.392479729673;872.6945569050845;1719.9017199017185;1726.1800644693797;1728.2482120277593;1745.8874761538555;8546.273566746833;8690.174433428814;8708.303335733126;8712.21590056898;8714.694985675535;3353.832308384571;3355.5134505497053;3393.9660603394145;3395.422778127724;3404.4042292598697;7156.534825236343;7156.82107947295;7161;7170.713171473083;7182.317679820513;3722.664960153545;3725.9068523287133;3733.14137748314;3745.8314375852606;3748.0629842539365;3404.097914052778;3412.4369479036177;3426.9828650856584;3428.177237462991;3455.188030812757;2942.6321709786275;2947.5873377726707;2956.556516522539;2969.1834745445176;2982.8359440230997;856.6444925356033;859.3984211052289;870.0559892516691;871.2637821041337;871.5119533061505;909.5770466733001;918.2745630951607;935.2517985611483;963.2631037256505;1146.8451759012594;6110.052941794029;6152;6176.81469555914;6182.969085154546;6188.659623720739;1010.3836659637615;1014.700663304327;1031.9845202321972;1035.803197392493;1057.0961827637414;5080.949190508121;5086.669366491166;5124.205748109049;5126.461721519261;5127.743612819344;7588.582627955405;7677.731279405194;7710.228977102357;7816.960915195501;7871.173526779606;7757.92242077572;7771.883421748678;7794.103678077094;7799.610019499002;7846.529208247409;6294.181756371642;6329.936700633027;6345.49236061114;6357.809265722036;6358.141650877073;6043.36544662804;6159.538034647509;6166.105914642441;6178.474829639531;6192.752289908353;7015.894761578683;7113.518483355453;7143.785686429415;7171.354578087997;7274.927250727636;7153.248908864494;7251.8187045324285;7261.891071633824;7339.119305683139;7379.114506259283;5729.9713501432225;5762.740676669476;5764.164196191445;5784.190213370216;5791.53667706574;6172.5679202457195;6189.257289125154;6218.347073557211;6225.8132256032395;6233.283172435228;5931.288245410578;6123.173371594778;6154.969225153845;6212.937870621236;6228.906566401417;5099.184130539096;5335.653182543122;5516.42781807183;5639.830805075854;5717.256756621613;5827.912581311199;6029.57792954489;6046.244219472566;6089.451949324582;6126.111713801385;5738.340090889601;5749.7125143741805;5761.078227483583;5802.158686990447;5834.416558344132;5683.658980461186;5685.175649530877;5699.344575373885;5700.486956173964;5730.627509211888 04:45:36 INFO - 2015-12-02 04:45:36,676 DEBUG : BROWSER_OUTPUT: |4;prototype.html;285.7642444982889;293.47614508103027;294.386204763069;298.75800601512776;299.9755833827479;5512.393636699965;5591.245181900442;5605.971970140149;5619.466150715686;5665.660060396379;5534.418886016971;5545.805896793613;5554.50009499146;5554.527865131458;5566.86082847929;4327.069680018795;4327.112941846914;4327.740335579875;4330.873972767087;4334.934975975363;4140.896477588054;4250.723702959298;4263.744175349473;4276.550962148976;4299;4211.43145675333;4215.220184265905;4221.32458806591;4240;4256.148770245948;4226.1547690461875;4231.301835197204;4242.278812601865;4245.617894389489;4250.04374015847;3663.065918190871;3669.6697297243377;3670.0457880950876;3672.6510981456986;3672.8430544378434;5184.611154163415;5292.788288468457;5319.840404787863;5325.227841962933;5337.718947452622;4855.708657480527;4858.587020103296;4866.489018653026;4867.050925069613;4890.168671325883;5814.098814683731;5834.6790926499025;5838.328592211908;5843.181954526327;5857.794977175821;3967.7420967637013;3968.8809335719975;3968.980155099206;3974.920501589952;3980.2636512245326;5964.7912323068485;6071.817845464643;6141.324454310023;6175.907361389628;6182.690865456754;3984.6053881141947;4005.5794141615293;4015.3374693175883;4018.3168861293652;4024.7786371749835;4066.34938409853;4070.674346052309;4071.877843664695;4077.5922407758985;4085.611866872642;4751.904961900743;4767;4767.094252092161;4776.283557466339;4778.235482322882;5722.341930677942;5863.501602363762;5879.441453061952;5889.146073819272;5893.5579831512805;1436.4541474239932;1437.2813593203398;1439.7336492748875;1440.625437386287;1440.7262620102147;923.5197697197419;976.2531663277598;977.4721650308895;981.1660088924357;994.945278009702;5037.773300201499;5084.898302033938;5093.694378337312;5112.795488180431;5115.948840511622;5955.52355811534;6108.938910610926;6109.480694140959;6114;6119.265688117365;5106.744662766847;5129.820456284012;5132.255822905658;5134.845954621367;5149.124648809711;3266.2161081340782;3312.519684645713;3313.188268874141;3315.5689760331484;3330.167458135466;5781.103928890944;5799.9130013049835;5801.12983052537;5811.2445382100905;5814.360420353758;6143.692815359214;6331.873362532723;6334.1765570475545;6343.651099189497;6357.523185761086;5759.2512973313205;5788.507976821933;5795.275590551181;5801.9129713054335;5806;6153.66154861469;6155.784547540815;6158.969205153946;6162.22972128484;6167.629942203482;5892.970535147297;5968.194293770285;6003.549733770072;6006.429389208019;6009.939900600938;5777.826665200051;5781.884362312814;5784.652920824596;5785.537157027344;5790.218320526675;4026.879193624196;4032.858849940238;4038.374052021941;4052.9392059119727;4055.736377135595;5972.880542389041;6086.756529738761;6087.69561521931;6135.07973803933;6135.631862088289;5855;5855.063189889597;5878.030125029322;5889.94110058894;5897.174395584536;5874.471297583238;5884.32330282023;5887.146363777143;5889.293284805851;5889.646621202742;5764.596478246483;5766.163906233656;5770.163326317745;5782.45066718661;5790.10253410722;5700.686462244616;5831.504322132666;5844.561657875592;5859.414058594107;5890.381509941394;5783.566232532493;5801.883962320646;5808.477237048686;5808.651480911159;5817.94182058174 04:45:36 INFO - 2015-12-02 04:45:36,677 DEBUG : BROWSER_OUTPUT: |5;yui.html;691.6818263598744;762.8207371267748;778.0585491555221;778.3423007558613;787.2599756229145;10553.73615659608;10905.83641245382;10941.890581094196;11229.719257018578;11491.425428728571;12548.749025019493;12566.18319809214;12617;12629.747405051894;12666.62000139995;749.2769477454256;754.7886591754318;755.2787088330645;767.8349154931689;768.0974854545887;774.0672489649959;778.5640041576735;778.8052986753312;782.3428320211021;783.6786917363881;791.8812178173291;796.6016991504248;797.5214871077336;800.671724592917;800.7437619961614;790.4861839804116;792.627465091409;792.6789650191681;792.9286364227247;795.2643804480861;587.8030859662018;588.7350692188489;589.2487078974342;589.4047012517345;590.7607418995314;10993.230473866832;11114.666560003132;11129.109671226282;11133.276337038147;11172.162087843444;10719.732006699816;10800.513976870981;11031.944840275828;11152;11247.100231981422;9133.588988495534;9175.632974681004;9274.536273186313;9429.858552121723;9626.326157169002;3223.09753269085;3224.4679627861374;3275.852586633607;3290.68738469845;3297.653746356622;41699.999999999694;42065.78967105145;42206.15587688229;42222.366664500056;42298;7480.551166930001;7580.279873412017;7612.7716168515035;7617.542947423172;7625.199354067854;13061.738765224642;13224.140430871963;13302.800457993138;16281.67436651284;16427.342906283615;6422.775202867877;6555.475561955032;6595.043718660863;6606.636634985122;6635.635040072746;3725.403935370328;3744.8314825832904;3820.904477388032;3841.3277676407074;3898.9610103899167;2529.8355606885493;2549.0695895998197;2560.4111054457208;2579.252016915111;2588.352911772057;469.5609605019318;478.9185838407479;480.4426864836773;482.2043628013735;492.3550149304423;465.71591329289106;476.5520410813824;478.2754127496845;491.95818355439474;583.3291714528326;7052.753153639598;7365.705371785176;7635;7712.383009359238;7858.685652573948;441.4944888103104;478.8826737449347;508.3239291741974;590.2179612014013;594.8602078511547;3595;3675.1783571723454;3683.9447408288897;3751.099736063325;3820.121372084436;53045.469545304055;53731;53733.92532149335;53927.46072539303;54017.729911350194;47689.76155119202;47792.22077792193;47991;48237.517624823304;48481.757591212525;44345.77827110844;44450.77774611106;44683.10633787306;45166.32250516245;45938;7828.491148075357;7870.685172593032;8323.126071762377;8381.203785640355;8396.076431592397;33026.33947321088;33131;33307.83346083254;33513.83243083769;33600;41256;42543;42699.14601707886;43316.566834332516;43825;9662.613495460102;9834.803303933739;9882.50587470638;10016;10168.084872361524;10919.508622112184;10949.726256843642;11001.559937602406;11234.101271898391;11322.26405283654;10207.234457415872;10272;10448.32085914413;10473.162147028068;10624.84062739075;9685.225181985283;9714.562844672148;9761.219102471927;9985.1512621428;10033.548490317808;9164.770880728036;10411.167106631603;10797.136229101496;11391.886081139082;11459.942700286778;7996.6401511930935;8222.424430289822;8920.955395222982;9017.504037278013;9210.309226807882;8587.184217499327;8774.429662071945;8810.955945220232;8906.643734250558;9038 04:45:36 INFO - 2015-12-02 04:45:36,677 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:45:36 INFO - 2015-12-02 04:45:36,677 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:45:36 INFO - 2015-12-02 04:45:36,677 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,326 04:45:36 INFO - 2015-12-02 04:45:36,677 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:45:36 INFO - 2015-12-02 04:45:36,677 DEBUG : BROWSER_OUTPUT: __startTimestamp1449060336663__endTimestamp 04:45:36 INFO - 2015-12-02 04:45:36,678 DEBUG : BROWSER_OUTPUT: 04:45:36 INFO - 2015-12-02 04:45:36,678 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:45:36 INFO - 2015-12-02 04:45:36,678 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:45:36 INFO - 2015-12-02 04:45:36,678 DEBUG : BROWSER_OUTPUT: 04:45:36 INFO - 2015-12-02 04:45:36,678 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4620.97 Median:4719.32 stddev:468.15 (9.9%) stddev-sans-first:442.84 04:45:36 INFO - 2015-12-02 04:45:36,679 DEBUG : BROWSER_OUTPUT: Values: 2632.5 2666.3 2688.7 2710.4 2724.1 4471.9 4635.7 4650.8 4653.9 4719.3 4568.7 4631.2 4652.7 4701.0 4701.5 4257.3 4337.6 4385.3 4387.6 4449.8 4319.7 4342.3 4371.5 4450.1 4468.0 4135.2 4234.9 4241.1 4319.2 4324.8 4369.2 4373.4 4377.6 4384.5 4387.4 4350.5 4358.6 4365.9 4384.9 4409.3 4400.3 4521.6 4559.8 4624.6 4649.4 5021.7 5035.2 5047.8 5056.3 5104.1 5090.9 5094.8 5098.1 5103.5 5119.1 4501.2 4571.0 4595.2 4639.9 4688.0 5123.9 5125.1 5125.3 5141.7 5156.2 4743.7 4942.5 4945.5 4948.4 4996.2 4928.2 4935.2 4967.2 4995.5 5026.9 4961.9 4977.3 4979.4 4981.7 5027.3 4759.5 4869.4 4959.5 4960.3 5002.7 4158.4 4217.2 4220.4 4222.6 4258.6 3704.5 3745.6 3750.6 3777.2 3786.5 4184.8 4265.1 4265.9 4359.3 4364.5 4897.3 4973.2 5004.5 5034.7 5060.5 4331.5 4338.9 4372.3 4374.0 4401.0 4483.4 4509.1 4514.8 4517.7 4554.0 4588.1 4631.3 4669.7 4672.9 4693.6 4989.7 5002.7 5004.0 5020.5 5058.6 4592.6 4757.0 4763.6 4765.8 4810.9 4836.1 4893.5 4923.8 4945.0 4979.3 4971.1 4997.0 5016.0 5035.5 5079.1 4688.7 4782.5 4862.1 4876.1 4911.0 4729.9 4798.2 4811.2 4818.6 4848.9 4730.2 4747.4 4758.4 4766.5 4773.2 4718.8 4795.0 4826.0 4896.4 4914.6 4835.8 4846.9 4873.5 4886.6 4920.9 04:45:36 INFO - 2015-12-02 04:45:36,680 DEBUG : BROWSER_OUTPUT: 04:45:36 INFO - 2015-12-02 04:45:36,680 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43104.77 Median:37092.72 stddev:70719.20 (190.7%) stddev-sans-first:70845.39 04:45:36 INFO - 2015-12-02 04:45:36,680 DEBUG : BROWSER_OUTPUT: Values: 547.2 559.9 568.9 569.2 576.4 35802.1 37090.0 37150.0 37208.6 37304.4 40036.8 40516.2 40516.4 40752.0 40798.6 7953.6 8060.8 8063.7 8121.6 8146.4 7836.7 7915.0 7992.8 8028.4 8053.0 7923.2 8022.2 8035.2 8056.1 8062.2 7921.6 8023.2 8028.3 8036.5 8046.3 7897.2 7940.0 7955.0 8008.8 8026.6 36826.6 37376.8 37398.8 37403.6 37450.3 2834.5 2849.7 2908.3 2963.8 3017.9 28095.0 28242.9 28375.9 28479.9 28750.3 3350.6 3402.6 3451.7 3454.7 3537.1 213599.0 216446.0 217194.0 217504.0 218146.0 51391.7 51712.0 51786.7 52017.2 52026.0 57921.4 58107.0 58262.7 58864.4 58898.1 11461.9 11616.4 11637.9 11639.5 11695.5 8539.9 8541.7 8550.1 8550.9 8567.7 18797.7 19158.1 19276.1 19306.9 19343.5 7597.4 7657.3 7740.0 7793.0 7841.9 860.3 895.5 915.2 981.9 1029.8 25412.2 25614.4 25674.5 25815.5 25897.7 896.5 940.6 1020.7 1033.8 1039.3 13886.4 14290.6 14564.0 14736.7 14886.6 327350.0 328981.0 330739.8 330887.0 331885.0 47892.0 48001.0 48134.5 48177.8 48205.5 1187.9 1200.4 1219.6 1237.5 1239.7 27163.0 27282.3 27491.9 28125.4 28308.0 40157.8 40157.8 40434.4 40485.6 40511.6 248827.0 252027.0 252679.0 252700.0 253066.0 29469.7 41443.0 41946.2 42696.8 42747.6 38192.2 39011.6 39170.0 39438.8 40170.0 33661.2 34128.8 34192.8 34621.3 35367.0 35664.3 36449.1 36900.0 37095.4 37328.0 35075.8 35879.6 36137.0 36243.1 36741.8 34156.7 34940.8 35635.5 35930.8 36093.8 25007.5 25115.2 25411.5 25426.0 25710.6 04:45:36 INFO - 2015-12-02 04:45:36,680 DEBUG : BROWSER_OUTPUT: 04:45:36 INFO - 2015-12-02 04:45:36,680 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29004.38 Median:15744.48 stddev:87421.18 (555.2%) stddev-sans-first:87639.87 04:45:36 INFO - 2015-12-02 04:45:36,681 DEBUG : BROWSER_OUTPUT: Values: 310.7 317.9 320.2 320.3 323.9 14448.3 14934.3 15339.6 15521.5 16382.1 8380.7 8424.9 8434.4 8437.7 8541.4 4335.4 4425.7 4430.3 4447.2 4467.7 4444.6 4456.3 4459.2 6321.3 6433.8 6419.5 6423.6 6426.1 6433.7 6444.7 6449.3 6683.2 6687.7 6712.5 6720.8 6125.4 6168.9 6407.4 6430.8 6431.3 20391.2 20735.8 20867.6 20881.3 21202.9 1818.4 1873.6 1944.2 1958.6 1976.7 13104.7 13184.3 13254.0 13336.9 13859.5 1827.1 1868.0 1871.7 1911.9 1924.2 57535.7 63085.4 65856.0 66504.3 67216.3 15588.3 15748.4 15782.6 15793.3 15794.1 10659.7 10908.5 23658.2 23703.6 23791.8 6085.3 6229.6 6242.1 6359.0 6473.4 5905.3 5915.2 5994.1 6036.0 6070.7 4024.5 4027.1 4030.2 4032.1 4048.6 1436.7 1592.9 1672.6 1677.7 1695.6 831.7 886.2 968.9 969.3 994.0 15220.5 15252.0 15802.2 15894.7 16292.8 837.5 883.7 902.8 905.7 940.2 8904.9 8926.7 9177.0 9294.0 9294.4 528537.0 531434.0 533089.0 539664.0 545650.0 68932.7 73786.0 73799.6 73855.3 74025.3 1024.2 1082.8 1134.7 1141.7 1146.4 13537.3 13782.3 13988.2 14197.6 14368.5 31178.2 32268.4 33286.7 33671.0 33854.5 47138.8 47833.5 50414.2 51750.0 51928.2 13884.4 14063.2 14316.4 14326.6 14495.6 17089.1 17639.1 17681.8 17846.2 17884.6 14153.4 14175.5 14430.6 14874.8 15351.3 13613.0 14589.8 14599.4 14633.2 15184.5 14071.4 14082.2 14383.6 14710.6 14750.6 13676.0 13733.0 13779.5 13872.6 13900.7 14402.3 14685.9 14721.6 14851.5 15063.5 04:45:36 INFO - 2015-12-02 04:45:36,681 DEBUG : BROWSER_OUTPUT: 04:45:36 INFO - 2015-12-02 04:45:36,681 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4620.83 Median:5774.18 stddev:2321.98 (40.2%) stddev-sans-first:2316.37 04:45:36 INFO - 2015-12-02 04:45:36,682 DEBUG : BROWSER_OUTPUT: Values: 1464.4 1595.7 1626.3 1631.5 1671.2 6314.1 6367.9 6689.4 6783.9 6787.5 6614.1 6616.2 6692.5 6695.8 6725.6 1927.6 1932.0 1942.8 1950.0 1951.6 1974.5 2008.9 2010.3 2012.3 2018.6 1904.5 1920.2 1928.2 1972.9 1973.0 1942.9 1968.3 1969.1 1969.6 1971.7 1947.7 1988.8 1989.0 1995.5 1995.6 6568.4 6689.0 6689.3 6691.6 6695.3 3784.7 3864.0 3864.4 3873.0 3884.2 2553.2 2565.6 2599.8 2638.7 2641.4 872.7 1719.9 1726.2 1728.2 1745.9 8546.3 8690.2 8708.3 8712.2 8714.7 3353.8 3355.5 3394.0 3395.4 3404.4 7156.5 7156.8 7161.0 7170.7 7182.3 3722.7 3725.9 3733.1 3745.8 3748.1 3404.1 3412.4 3427.0 3428.2 3455.2 2942.6 2947.6 2956.6 2969.2 2982.8 856.6 859.4 870.1 871.3 871.5 909.6 918.3 935.3 963.3 1146.8 6110.1 6152.0 6176.8 6183.0 6188.7 1010.4 1014.7 1032.0 1035.8 1057.1 5080.9 5086.7 5124.2 5126.5 5127.7 7588.6 7677.7 7710.2 7817.0 7871.2 7757.9 7771.9 7794.1 7799.6 7846.5 6294.2 6329.9 6345.5 6357.8 6358.1 6043.4 6159.5 6166.1 6178.5 6192.8 7015.9 7113.5 7143.8 7171.4 7274.9 7153.2 7251.8 7261.9 7339.1 7379.1 5730.0 5762.7 5764.2 5784.2 5791.5 6172.6 6189.3 6218.3 6225.8 6233.3 5931.3 6123.2 6155.0 6212.9 6228.9 5099.2 5335.7 5516.4 5639.8 5717.3 5827.9 6029.6 6046.2 6089.5 6126.1 5738.3 5749.7 5761.1 5802.2 5834.4 5683.7 5685.2 5699.3 5700.5 5730.6 04:45:36 INFO - 2015-12-02 04:45:36,683 DEBUG : BROWSER_OUTPUT: 04:45:36 INFO - 2015-12-02 04:45:36,683 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4834.93 Median:5579.05 stddev:1456.53 (26.1%) stddev-sans-first:1420.03 04:45:36 INFO - 2015-12-02 04:45:36,683 DEBUG : BROWSER_OUTPUT: Values: 285.8 293.5 294.4 298.8 300.0 5512.4 5591.2 5606.0 5619.5 5665.7 5534.4 5545.8 5554.5 5554.5 5566.9 4327.1 4327.1 4327.7 4330.9 4334.9 4140.9 4250.7 4263.7 4276.6 4299.0 4211.4 4215.2 4221.3 4240.0 4256.1 4226.2 4231.3 4242.3 4245.6 4250.0 3663.1 3669.7 3670.0 3672.7 3672.8 5184.6 5292.8 5319.8 5325.2 5337.7 4855.7 4858.6 4866.5 4867.1 4890.2 5814.1 5834.7 5838.3 5843.2 5857.8 3967.7 3968.9 3969.0 3974.9 3980.3 5964.8 6071.8 6141.3 6175.9 6182.7 3984.6 4005.6 4015.3 4018.3 4024.8 4066.3 4070.7 4071.9 4077.6 4085.6 4751.9 4767.0 4767.1 4776.3 4778.2 5722.3 5863.5 5879.4 5889.1 5893.6 1436.5 1437.3 1439.7 1440.6 1440.7 923.5 976.3 977.5 981.2 994.9 5037.8 5084.9 5093.7 5112.8 5115.9 5955.5 6108.9 6109.5 6114.0 6119.3 5106.7 5129.8 5132.3 5134.8 5149.1 3266.2 3312.5 3313.2 3315.6 3330.2 5781.1 5799.9 5801.1 5811.2 5814.4 6143.7 6331.9 6334.2 6343.7 6357.5 5759.3 5788.5 5795.3 5801.9 5806.0 6153.7 6155.8 6159.0 6162.2 6167.6 5893.0 5968.2 6003.5 6006.4 6009.9 5777.8 5781.9 5784.7 5785.5 5790.2 4026.9 4032.9 4038.4 4052.9 4055.7 5972.9 6086.8 6087.7 6135.1 6135.6 5855.0 5855.1 5878.0 5889.9 5897.2 5874.5 5884.3 5887.1 5889.3 5889.6 5764.6 5766.2 5770.2 5782.5 5790.1 5700.7 5831.5 5844.6 5859.4 5890.4 5783.6 5801.9 5808.5 5808.7 5817.9 04:45:36 INFO - 2015-12-02 04:45:36,683 DEBUG : BROWSER_OUTPUT: 04:45:36 INFO - 2015-12-02 04:45:36,683 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12578.69 Median:24234.96 stddev:14959.54 (61.7%) stddev-sans-first:14974.87 04:45:36 INFO - 2015-12-02 04:45:36,684 DEBUG : BROWSER_OUTPUT: Values: 691.7 762.8 778.1 778.3 787.3 10553.7 10905.8 10941.9 11229.7 11491.4 12548.7 12566.2 12617.0 12629.7 12666.6 749.3 754.8 755.3 767.8 768.1 774.1 778.6 778.8 782.3 783.7 791.9 796.6 797.5 800.7 800.7 790.5 792.6 792.7 792.9 795.3 587.8 588.7 589.2 589.4 590.8 10993.2 11114.7 11129.1 11133.3 11172.2 10719.7 10800.5 11031.9 11152.0 11247.1 9133.6 9175.6 9274.5 9429.9 9626.3 3223.1 3224.5 3275.9 3290.7 3297.7 41700.0 42065.8 42206.2 42222.4 42298.0 7480.6 7580.3 7612.8 7617.5 7625.2 13061.7 13224.1 13302.8 16281.7 16427.3 6422.8 6555.5 6595.0 6606.6 6635.6 3725.4 3744.8 3820.9 3841.3 3899.0 2529.8 2549.1 2560.4 2579.3 2588.4 469.6 478.9 480.4 482.2 492.4 465.7 476.6 478.3 492.0 583.3 7052.8 7365.7 7635.0 7712.4 7858.7 441.5 478.9 508.3 590.2 594.9 3595.0 3675.2 3683.9 3751.1 3820.1 53045.5 53731.0 53733.9 53927.5 54017.7 47689.8 47792.2 47991.0 48237.5 48481.8 44345.8 44450.8 44683.1 45166.3 45938.0 7828.5 7870.7 8323.1 8381.2 8396.1 33026.3 33131.0 33307.8 33513.8 33600.0 41256.0 42543.0 42699.1 43316.6 43825.0 9662.6 9834.8 9882.5 10016.0 10168.1 10919.5 10949.7 11001.6 11234.1 11322.3 10207.2 10272.0 10448.3 10473.2 10624.8 9685.2 9714.6 9761.2 9985.2 10033.5 9164.8 10411.2 10797.1 11391.9 11459.9 7996.6 8222.4 8921.0 9017.5 9210.3 8587.2 8774.4 8811.0 8906.6 9038.0 04:45:36 INFO - 2015-12-02 04:45:36,685 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:45:36 INFO - 2015-12-02 04:45:36,685 DEBUG : BROWSER_OUTPUT: 04:45:37 INFO - 2015-12-02 04:45:37,469 INFO : Browser exited with error code: 0 04:45:37 INFO - 2015-12-02 04:45:37,488 INFO : Completed test dromaeo_css (00:18:34) 04:45:37 INFO - 2015-12-02 04:45:37,488 INFO : Starting test kraken 04:45:37 INFO - 2015-12-02 04:45:37,488 DEBUG : operating with platform_type : linux_ 04:45:37 INFO - 2015-12-02 04:45:37,488 INFO : Initialising browser for kraken test... 04:45:37 INFO - 2015-12-02 04:45:37,494 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpChP_2b/profile http://localhost:48490/getInfo.html 04:45:42 INFO - 2015-12-02 04:45:42,281 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:45:42 INFO - 2015-12-02 04:45:42,281 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:45:42 INFO - 2015-12-02 04:45:42,282 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:45:42 INFO - 2015-12-02 04:45:42,282 DEBUG : BROWSER_OUTPUT: __metrics 04:45:43 INFO - 2015-12-02 04:45:43,349 INFO : Browser initialized. 04:45:43 INFO - 2015-12-02 04:45:43,350 INFO : Running cycle 1/1 for kraken test... 04:45:43 INFO - 2015-12-02 04:45:43,350 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpChP_2b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:45:55 INFO - 2015-12-02 04:45:55,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 139268096 04:45:55 INFO - 2015-12-02 04:45:55,246 DEBUG : BROWSER_OUTPUT: 04:45:57 INFO - 2015-12-02 04:45:57,846 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48490/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48490/tests/kraken/driver.html?testName=audio-beat-detection) 04:45:58 INFO - 2015-12-02 04:45:58,480 DEBUG : BROWSER_OUTPUT: RSS: Main: 140984320 04:45:58 INFO - 2015-12-02 04:45:58,480 DEBUG : BROWSER_OUTPUT: 04:46:01 INFO - 2015-12-02 04:46:01,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48490/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48490/tests/kraken/driver.html?testName=audio-dft) 04:46:01 INFO - 2015-12-02 04:46:01,831 DEBUG : BROWSER_OUTPUT: RSS: Main: 140697600 04:46:01 INFO - 2015-12-02 04:46:01,831 DEBUG : BROWSER_OUTPUT: 04:46:04 INFO - 2015-12-02 04:46:04,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48490/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48490/tests/kraken/driver.html?testName=audio-fft) 04:46:05 INFO - 2015-12-02 04:46:05,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 135880704 04:46:05 INFO - 2015-12-02 04:46:05,324 DEBUG : BROWSER_OUTPUT: 04:46:07 INFO - 2015-12-02 04:46:07,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48490/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48490/tests/kraken/driver.html?testName=audio-oscillator) 04:46:07 INFO - 2015-12-02 04:46:07,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 136110080 04:46:07 INFO - 2015-12-02 04:46:07,988 DEBUG : BROWSER_OUTPUT: 04:46:10 INFO - 2015-12-02 04:46:10,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48490/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48490/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:46:10 INFO - 2015-12-02 04:46:10,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 136245248 04:46:10 INFO - 2015-12-02 04:46:10,828 DEBUG : BROWSER_OUTPUT: 04:46:13 INFO - 2015-12-02 04:46:13,908 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48490/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48490/tests/kraken/driver.html?testName=imaging-darkroom) 04:46:14 INFO - 2015-12-02 04:46:14,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 136421376 04:46:14 INFO - 2015-12-02 04:46:14,501 DEBUG : BROWSER_OUTPUT: 04:46:18 INFO - 2015-12-02 04:46:18,003 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48490/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48490/tests/kraken/driver.html?testName=imaging-desaturate) 04:46:18 INFO - 2015-12-02 04:46:18,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 135340032 04:46:18 INFO - 2015-12-02 04:46:18,605 DEBUG : BROWSER_OUTPUT: 04:46:21 INFO - 2015-12-02 04:46:21,556 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48490/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48490/tests/kraken/driver.html?testName=json-parse-financial) 04:46:22 INFO - 2015-12-02 04:46:22,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 136654848 04:46:22 INFO - 2015-12-02 04:46:22,145 DEBUG : BROWSER_OUTPUT: 04:46:23 INFO - 2015-12-02 04:46:23,940 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48490/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48490/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:46:24 INFO - 2015-12-02 04:46:24,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 138686464 04:46:24 INFO - 2015-12-02 04:46:24,522 DEBUG : BROWSER_OUTPUT: 04:46:26 INFO - 2015-12-02 04:46:26,424 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48490/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48490/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:46:27 INFO - 2015-12-02 04:46:27,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 137895936 04:46:27 INFO - 2015-12-02 04:46:27,030 DEBUG : BROWSER_OUTPUT: 04:46:29 INFO - 2015-12-02 04:46:29,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48490/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48490/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:46:29 INFO - 2015-12-02 04:46:29,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 137220096 04:46:29 INFO - 2015-12-02 04:46:29,788 DEBUG : BROWSER_OUTPUT: 04:46:32 INFO - 2015-12-02 04:46:32,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48490/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48490/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:46:32 INFO - 2015-12-02 04:46:32,991 DEBUG : BROWSER_OUTPUT: RSS: Main: 137297920 04:46:32 INFO - 2015-12-02 04:46:32,991 DEBUG : BROWSER_OUTPUT: 04:46:35 INFO - 2015-12-02 04:46:35,591 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48490/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48490/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:46:36 INFO - 2015-12-02 04:46:36,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 138694656 04:46:36 INFO - 2015-12-02 04:46:36,192 DEBUG : BROWSER_OUTPUT: 04:46:37 INFO - 2015-12-02 04:46:37,961 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48490/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48490/tests/kraken/driver.html?testName=ai-astar) 04:46:38 INFO - 2015-12-02 04:46:38,211 DEBUG : BROWSER_OUTPUT: RSS: Main: 138633216 04:46:38 INFO - 2015-12-02 04:46:38,212 DEBUG : BROWSER_OUTPUT: 04:46:38 INFO - 2015-12-02 04:46:38,213 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:46:38 INFO - 2015-12-02 04:46:38,213 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:46:38 INFO - 2015-12-02 04:46:38,214 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:46:38 INFO - 2015-12-02 04:46:38,214 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:46:38 INFO - 2015-12-02 04:46:38,214 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;110;113;112;113;127;113;114;113;112 04:46:38 INFO - 2015-12-02 04:46:38,214 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;132;156;164;133;171;154;133;170;133 04:46:38 INFO - 2015-12-02 04:46:38,214 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;167;164;163;161;167;171;164;166;162 04:46:38 INFO - 2015-12-02 04:46:38,215 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;73;71;76;140;72;73;73;73 04:46:38 INFO - 2015-12-02 04:46:38,215 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;96;134;93;95;95;131;93;95;132 04:46:38 INFO - 2015-12-02 04:46:38,215 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;111;109;110;109;109;110;111;111;111 04:46:38 INFO - 2015-12-02 04:46:38,215 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;148;148;149;149;150;148;148;147 04:46:38 INFO - 2015-12-02 04:46:38,215 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;96;95;97;95;99;96;99 04:46:38 INFO - 2015-12-02 04:46:38,215 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;74;75;75;76;77;75;79;75;74 04:46:38 INFO - 2015-12-02 04:46:38,216 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;70;70;69;70;70;69;69;70;68 04:46:38 INFO - 2015-12-02 04:46:38,216 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;83;84;84;83;84;83;84;83;83 04:46:38 INFO - 2015-12-02 04:46:38,216 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;136;128;127;133;137;136;129;125;122;130 04:46:38 INFO - 2015-12-02 04:46:38,216 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;151;147;149;144;147;147;137;149;148;147 04:46:38 INFO - 2015-12-02 04:46:38,216 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;86;71;70;71;71;70;71;72;68;69 04:46:38 INFO - 2015-12-02 04:46:38,216 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:46:38 INFO - 2015-12-02 04:46:38,217 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:46:38 INFO - 2015-12-02 04:46:38,217 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,778 04:46:38 INFO - 2015-12-02 04:46:38,217 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:46:38 INFO - 2015-12-02 04:46:38,217 DEBUG : BROWSER_OUTPUT: __startTimestamp1449060398212__endTimestamp 04:46:38 INFO - 2015-12-02 04:46:38,217 DEBUG : BROWSER_OUTPUT: 04:46:38 INFO - 2015-12-02 04:46:38,221 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:46:38 INFO - 2015-12-02 04:46:38,221 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:46:38 INFO - 2015-12-02 04:46:38,221 DEBUG : BROWSER_OUTPUT: 04:46:38 INFO - 2015-12-02 04:46:38,221 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.20 Median:113.00 stddev:4.69 (4.1%) stddev-sans-first:4.96 04:46:38 INFO - 2015-12-02 04:46:38,222 DEBUG : BROWSER_OUTPUT: Values: 115.0 110.0 113.0 112.0 113.0 127.0 113.0 114.0 113.0 112.0 04:46:38 INFO - 2015-12-02 04:46:38,222 DEBUG : BROWSER_OUTPUT: 04:46:38 INFO - 2015-12-02 04:46:38,222 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.40 Median:157.00 stddev:16.13 (10.3%) stddev-sans-first:16.88 04:46:38 INFO - 2015-12-02 04:46:38,222 DEBUG : BROWSER_OUTPUT: Values: 158.0 132.0 156.0 164.0 133.0 171.0 154.0 133.0 170.0 133.0 04:46:38 INFO - 2015-12-02 04:46:38,222 DEBUG : BROWSER_OUTPUT: 04:46:38 INFO - 2015-12-02 04:46:38,222 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:165.00 Median:165.50 stddev:2.91 (1.8%) stddev-sans-first:3.08 04:46:38 INFO - 2015-12-02 04:46:38,223 DEBUG : BROWSER_OUTPUT: Values: 165.0 167.0 164.0 163.0 161.0 167.0 171.0 164.0 166.0 162.0 04:46:38 INFO - 2015-12-02 04:46:38,223 DEBUG : BROWSER_OUTPUT: 04:46:38 INFO - 2015-12-02 04:46:38,223 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.80 Median:73.00 stddev:21.19 (29.0%) stddev-sans-first:22.33 04:46:38 INFO - 2015-12-02 04:46:38,224 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 73.0 71.0 76.0 140.0 72.0 73.0 73.0 73.0 04:46:38 INFO - 2015-12-02 04:46:38,225 DEBUG : BROWSER_OUTPUT: 04:46:38 INFO - 2015-12-02 04:46:38,225 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.80 Median:94.50 stddev:18.35 (19.4%) stddev-sans-first:18.96 04:46:38 INFO - 2015-12-02 04:46:38,225 DEBUG : BROWSER_OUTPUT: Values: 94.0 96.0 134.0 93.0 95.0 95.0 131.0 93.0 95.0 132.0 04:46:38 INFO - 2015-12-02 04:46:38,225 DEBUG : BROWSER_OUTPUT: 04:46:38 INFO - 2015-12-02 04:46:38,225 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:111.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 04:46:38 INFO - 2015-12-02 04:46:38,225 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 109.0 110.0 109.0 109.0 110.0 111.0 111.0 111.0 04:46:38 INFO - 2015-12-02 04:46:38,225 DEBUG : BROWSER_OUTPUT: 04:46:38 INFO - 2015-12-02 04:46:38,225 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 04:46:38 INFO - 2015-12-02 04:46:38,226 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 148.0 148.0 149.0 149.0 150.0 148.0 148.0 147.0 04:46:38 INFO - 2015-12-02 04:46:38,226 DEBUG : BROWSER_OUTPUT: 04:46:38 INFO - 2015-12-02 04:46:38,226 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.51 (1.6%) stddev-sans-first:1.59 04:46:38 INFO - 2015-12-02 04:46:38,226 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 96.0 95.0 97.0 95.0 99.0 96.0 99.0 04:46:38 INFO - 2015-12-02 04:46:38,226 DEBUG : BROWSER_OUTPUT: 04:46:38 INFO - 2015-12-02 04:46:38,226 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.40 Median:75.00 stddev:1.58 (2.1%) stddev-sans-first:1.59 04:46:38 INFO - 2015-12-02 04:46:38,226 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 75.0 75.0 76.0 77.0 75.0 79.0 75.0 74.0 04:46:38 INFO - 2015-12-02 04:46:38,226 DEBUG : BROWSER_OUTPUT: 04:46:38 INFO - 2015-12-02 04:46:38,226 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:70.00 stddev:0.82 (1.2%) stddev-sans-first:0.73 04:46:38 INFO - 2015-12-02 04:46:38,226 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 70.0 69.0 70.0 70.0 69.0 69.0 70.0 68.0 04:46:38 INFO - 2015-12-02 04:46:38,226 DEBUG : BROWSER_OUTPUT: 04:46:38 INFO - 2015-12-02 04:46:38,226 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.50 stddev:0.92 (1.1%) stddev-sans-first:0.53 04:46:38 INFO - 2015-12-02 04:46:38,226 DEBUG : BROWSER_OUTPUT: Values: 81.0 83.0 84.0 84.0 83.0 84.0 83.0 84.0 83.0 83.0 04:46:38 INFO - 2015-12-02 04:46:38,226 DEBUG : BROWSER_OUTPUT: 04:46:38 INFO - 2015-12-02 04:46:38,227 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:131.50 stddev:5.08 (3.9%) stddev-sans-first:4.95 04:46:38 INFO - 2015-12-02 04:46:38,227 DEBUG : BROWSER_OUTPUT: Values: 136.0 128.0 127.0 133.0 137.0 136.0 129.0 125.0 122.0 130.0 04:46:38 INFO - 2015-12-02 04:46:38,227 DEBUG : BROWSER_OUTPUT: 04:46:38 INFO - 2015-12-02 04:46:38,227 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.60 Median:147.50 stddev:3.84 (2.6%) stddev-sans-first:3.72 04:46:38 INFO - 2015-12-02 04:46:38,227 DEBUG : BROWSER_OUTPUT: Values: 151.0 147.0 149.0 144.0 147.0 147.0 137.0 149.0 148.0 147.0 04:46:38 INFO - 2015-12-02 04:46:38,227 DEBUG : BROWSER_OUTPUT: 04:46:38 INFO - 2015-12-02 04:46:38,227 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:71.00 stddev:5.09 (7.2%) stddev-sans-first:1.22 04:46:38 INFO - 2015-12-02 04:46:38,227 DEBUG : BROWSER_OUTPUT: Values: 86.0 71.0 70.0 71.0 71.0 70.0 71.0 72.0 68.0 69.0 04:46:38 INFO - 2015-12-02 04:46:38,227 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:46:38 INFO - 2015-12-02 04:46:38,227 DEBUG : BROWSER_OUTPUT: 04:46:39 INFO - 2015-12-02 04:46:39,101 INFO : Browser exited with error code: 0 04:46:39 INFO - 2015-12-02 04:46:39,152 INFO : Completed test kraken (00:01:01) 04:46:39 INFO - 2015-12-02 04:46:39,153 INFO : Starting test v8_7 04:46:39 INFO - 2015-12-02 04:46:39,153 DEBUG : operating with platform_type : linux_ 04:46:39 INFO - 2015-12-02 04:46:39,153 INFO : Initialising browser for v8_7 test... 04:46:39 INFO - 2015-12-02 04:46:39,159 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3CcO82/profile http://localhost:48490/getInfo.html 04:46:43 INFO - 2015-12-02 04:46:43,984 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:46:43 INFO - 2015-12-02 04:46:43,985 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:46:43 INFO - 2015-12-02 04:46:43,985 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:46:43 INFO - 2015-12-02 04:46:43,985 DEBUG : BROWSER_OUTPUT: __metrics 04:46:44 INFO - 2015-12-02 04:46:44,973 INFO : Browser initialized. 04:46:44 INFO - 2015-12-02 04:46:44,974 INFO : Running cycle 1/1 for v8_7 test... 04:46:44 INFO - 2015-12-02 04:46:44,974 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3CcO82/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:46:56 INFO - 2015-12-02 04:46:56,893 DEBUG : BROWSER_OUTPUT: RSS: Main: 141250560 04:46:56 INFO - 2015-12-02 04:46:56,893 DEBUG : BROWSER_OUTPUT: 04:47:18 INFO - 2015-12-02 04:47:18,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48490/tests/v8_7/run.html (next: http://localhost:48490/tests/v8_7/run.html) 04:47:18 INFO - 2015-12-02 04:47:18,590 DEBUG : BROWSER_OUTPUT: RSS: Main: 137621504 04:47:18 INFO - 2015-12-02 04:47:18,590 DEBUG : BROWSER_OUTPUT: 04:47:18 INFO - 2015-12-02 04:47:18,591 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:47:18 INFO - 2015-12-02 04:47:18,591 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:47:18 INFO - 2015-12-02 04:47:18,591 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:47:18 INFO - 2015-12-02 04:47:18,591 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:47:18 INFO - 2015-12-02 04:47:18,591 DEBUG : BROWSER_OUTPUT: |0;Richards;166.27868307283006 04:47:18 INFO - 2015-12-02 04:47:18,591 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;183.75597206909225 04:47:18 INFO - 2015-12-02 04:47:18,591 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.54648903691367 04:47:18 INFO - 2015-12-02 04:47:18,591 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 04:47:18 INFO - 2015-12-02 04:47:18,591 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1072.961373390558 04:47:18 INFO - 2015-12-02 04:47:18,592 DEBUG : BROWSER_OUTPUT: |5;Earley;702.9494382022472 04:47:18 INFO - 2015-12-02 04:47:18,592 DEBUG : BROWSER_OUTPUT: |6;Boyer;12219.512195121952 04:47:18 INFO - 2015-12-02 04:47:18,592 DEBUG : BROWSER_OUTPUT: |7;RegExp;25641.02564102564 04:47:18 INFO - 2015-12-02 04:47:18,592 DEBUG : BROWSER_OUTPUT: |8;Splay;621.1180124223603 04:47:18 INFO - 2015-12-02 04:47:18,592 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 04:47:18 INFO - 2015-12-02 04:47:18,592 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:47:18 INFO - 2015-12-02 04:47:18,592 DEBUG : BROWSER_OUTPUT: __startTimestamp1449060438589__endTimestamp 04:47:18 INFO - 2015-12-02 04:47:18,592 DEBUG : BROWSER_OUTPUT: 04:47:18 INFO - 2015-12-02 04:47:18,594 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:47:18 INFO - 2015-12-02 04:47:18,594 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:47:18 INFO - 2015-12-02 04:47:18,594 DEBUG : BROWSER_OUTPUT: 04:47:18 INFO - 2015-12-02 04:47:18,594 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.28 Median:166.28 stddev:0.00 (0.0%) 04:47:18 INFO - 2015-12-02 04:47:18,594 DEBUG : BROWSER_OUTPUT: Values: 166.3 04:47:18 INFO - 2015-12-02 04:47:18,594 DEBUG : BROWSER_OUTPUT: 04:47:18 INFO - 2015-12-02 04:47:18,594 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:183.76 Median:183.76 stddev:0.00 (0.0%) 04:47:18 INFO - 2015-12-02 04:47:18,594 DEBUG : BROWSER_OUTPUT: Values: 183.8 04:47:18 INFO - 2015-12-02 04:47:18,594 DEBUG : BROWSER_OUTPUT: 04:47:18 INFO - 2015-12-02 04:47:18,594 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.55 Median:277.55 stddev:0.00 (0.0%) 04:47:18 INFO - 2015-12-02 04:47:18,595 DEBUG : BROWSER_OUTPUT: Values: 277.5 04:47:18 INFO - 2015-12-02 04:47:18,595 DEBUG : BROWSER_OUTPUT: 04:47:18 INFO - 2015-12-02 04:47:18,595 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 04:47:18 INFO - 2015-12-02 04:47:18,595 DEBUG : BROWSER_OUTPUT: Values: 5202.1 04:47:18 INFO - 2015-12-02 04:47:18,595 DEBUG : BROWSER_OUTPUT: 04:47:18 INFO - 2015-12-02 04:47:18,595 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1072.96 Median:1072.96 stddev:0.00 (0.0%) 04:47:18 INFO - 2015-12-02 04:47:18,595 DEBUG : BROWSER_OUTPUT: Values: 1073.0 04:47:18 INFO - 2015-12-02 04:47:18,595 DEBUG : BROWSER_OUTPUT: 04:47:18 INFO - 2015-12-02 04:47:18,596 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:702.95 Median:702.95 stddev:0.00 (0.0%) 04:47:18 INFO - 2015-12-02 04:47:18,596 DEBUG : BROWSER_OUTPUT: Values: 702.9 04:47:18 INFO - 2015-12-02 04:47:18,596 DEBUG : BROWSER_OUTPUT: 04:47:18 INFO - 2015-12-02 04:47:18,596 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 04:47:18 INFO - 2015-12-02 04:47:18,596 DEBUG : BROWSER_OUTPUT: Values: 12219.5 04:47:18 INFO - 2015-12-02 04:47:18,596 DEBUG : BROWSER_OUTPUT: 04:47:18 INFO - 2015-12-02 04:47:18,596 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25641.03 Median:25641.03 stddev:0.00 (0.0%) 04:47:18 INFO - 2015-12-02 04:47:18,597 DEBUG : BROWSER_OUTPUT: Values: 25641.0 04:47:18 INFO - 2015-12-02 04:47:18,597 DEBUG : BROWSER_OUTPUT: 04:47:18 INFO - 2015-12-02 04:47:18,597 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:621.12 Median:621.12 stddev:0.00 (0.0%) 04:47:18 INFO - 2015-12-02 04:47:18,597 DEBUG : BROWSER_OUTPUT: Values: 621.1 04:47:18 INFO - 2015-12-02 04:47:18,597 DEBUG : BROWSER_OUTPUT: 04:47:18 INFO - 2015-12-02 04:47:18,597 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 04:47:18 INFO - 2015-12-02 04:47:18,597 DEBUG : BROWSER_OUTPUT: Values: 4840.6 04:47:18 INFO - 2015-12-02 04:47:18,597 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:47:18 INFO - 2015-12-02 04:47:18,598 DEBUG : BROWSER_OUTPUT: 04:47:19 INFO - 2015-12-02 04:47:19,473 INFO : Browser exited with error code: 0 04:47:19 INFO - 2015-12-02 04:47:19,485 INFO : Completed test v8_7 (00:00:40) 04:47:19 INFO - 2015-12-02 04:47:19,618 INFO : Completed test suite (00:20:16) 04:47:19 INFO - 2015-12-02 04:47:19,618 DEBUG : Working with test: dromaeo_css 04:47:19 INFO - 2015-12-02 04:47:19,618 DEBUG : Generating results file: dromaeo_css 04:47:19 INFO - 2015-12-02 04:47:19,619 DEBUG : Working with test: kraken 04:47:19 INFO - 2015-12-02 04:47:19,619 DEBUG : Generating results file: kraken 04:47:19 INFO - 2015-12-02 04:47:19,620 INFO : javascript benchmark 04:47:19 INFO - 2015-12-02 04:47:19,620 DEBUG : Working with test: v8_7 04:47:19 INFO - 2015-12-02 04:47:19,620 DEBUG : Generating results file: v8_7 04:47:19 INFO - 2015-12-02 04:47:19,620 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:47:19 INFO - 2015-12-02 04:47:19,679 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 04:47:19 INFO - 2015-12-02 04:47:19,679 DEBUG : process_Request line: dromaeo_css 6382.91 graph.html#tests=[[72,132,43]] 04:47:19 INFO - 2015-12-02 04:47:19,680 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:47:19 INFO - 2015-12-02 04:47:19,715 DEBUG : process_Request line: kraken 1546.70 graph.html#tests=[[232,132,43]] 04:47:19 INFO - 2015-12-02 04:47:19,715 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:47:19 INFO - 2015-12-02 04:47:19,746 DEBUG : process_Request line: v8_7 21373.34 graph.html#tests=[[230,132,43]] 04:47:19 INFO - 2015-12-02 04:47:19,747 INFO : javascript benchmark 04:47:19 INFO - 2015-12-02 04:47:19,751 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2632.512985097757, 2666.3067602423366, 2688.6639170103736, 2710.3901622135018, 2724.101046654603, 4471.888202794924, 4635.675502714816, 4650.767461626922, 4653.906921861565, 4719.315699223611, 4568.748718820463, 4631.16639004979, 4652.720836749789, 4700.952990470094, 4701.48283688794, 4257.276263035276, 4337.63130133939, 4385.254506733863, 4387.605115539601, 4449.799759010836, 4319.740815551077, 4342.3052311630145, 4371.453568303962, 4450.087732014946, 4467.994701192222, 4135.1729654069, 4234.85178018771, 4241.066965267636, 4319.222539942824, 4324.783760811947, 4369.169857727022, 4373.365861950031, 4377.562243775597, 4384.495782984965, 4387.429634147572, 4350.521442641307, 4358.564143585648, 4365.912681746379, 4384.89037774055, 4409.338599210144, 4400.295952647561, 4521.638268938477, 4559.794809233593, 4624.606908412756, 4649.372334734835, 5021.673591216596, 5035.219540971156, 5047.823326183566, 5056.342675452168, 5104.05574968632, 5090.872728181788, 5094.770735316883, 5098.082345177866, 5103.515166059218, 5119.129747942859, 4501.167284052461, 4571.0, 4595.241785105453, 4639.884002899887, 4687.95312046882, 5123.87190320245, 5125.051865404912, 5125.256837758504, 5141.742912854343, 5156.1750119980625, 4743.691660042086, 4942.481039490874, 4945.455999840015, 4948.4309304429735, 4996.200607902718, 4928.211486162197, 4935.235038569028, 4967.180415231519, 4995.500449954975, 5026.949730502648, 4961.90076198474, 4977.253411988231, 4979.377577802775, 4981.726005069683, 5027.296178535008, 4759.547842954914, 4869.415670119608, 4959.454460009396, 4960.280759289883, 5002.674826136289, 4158.355454904495, 4217.156568686275, 4220.430241917364, 4222.641075508616, 4258.552851950562, 3704.5369328833895, 3745.5879853216125, 3750.624937506282, 3777.20678657485, 3786.545614526219, 4184.769837658958, 4265.1469706058915, 4265.936010959838, 4359.346098085312, 4364.54172311909, 4897.265410188429, 4973.229149481836, 5004.524570165829, 5034.723090229999, 5060.49395060491, 4331.480222373272, 4338.913221735547, 4372.344148377769, 4373.956260437355, 4400.9559904401185, 4483.439570053743, 4509.098180363941, 4514.751688657156, 4517.706349087299, 4554.020885509632, 4588.082383523309, 4631.328457373729, 4669.719816811003, 4672.883177920511, 4693.577578017995, 4989.700617962933, 5002.674826136289, 5004.0, 5020.523050310215, 5058.595312375075, 4592.609628181508, 4757.048590281888, 4763.618910487222, 4765.76171191446, 4810.855674329776, 4836.105320515716, 4893.486183950777, 4923.778429970588, 4944.950550494593, 4979.253112033224, 4971.135824065976, 4997.0, 5016.046951079284, 5035.496450354935, 5079.136546787129, 4688.671792974459, 4782.497837726988, 4862.149123903232, 4876.122297986397, 4911.0, 4729.929051064168, 4798.1843086676045, 4811.206150985048, 4818.638602104786, 4848.878778030577, 4730.1958667026, 4747.406574178228, 4758.357621721162, 4766.475687674284, 4773.236282194832, 4718.7640617969655, 4795.0, 4826.034793041476, 4896.4124305083615, 4914.557689807934, 4835.8065677372515, 4846.927296090632, 4873.51264873524, 4886.560209581155, 4920.926186107283], "unit": "ms", "name": "dojo.html", "value": 4592.551353932359}, {"lowerIsBetter": false, "replicates": [547.2448021730012, 559.9132134519151, 568.8862227554488, 569.154805114405, 576.3717547872818, 35802.13582913367, 37090.0, 37150.0, 37208.627913720855, 37304.44043339349, 40036.79981600088, 40516.18967620646, 40516.39225411621, 40752.0, 40798.59201407985, 7953.602319883998, 8060.798480038016, 8063.717769878055, 8121.593920303991, 8146.429749917508, 7836.72571459999, 7914.960425197866, 7992.760217193493, 8028.357731381505, 8053.033635963663, 7923.247291507298, 8022.237887400717, 8035.196480351948, 8056.07355154156, 8062.234087761653, 7921.56431396273, 8023.237792409712, 8028.317593004602, 8036.4776289541, 8046.316063134641, 7897.17079706634, 7940.0, 7954.9602251988945, 8008.839823203503, 8026.598670066532, 36826.63173368259, 37376.813115934245, 37398.8130059348, 37403.62596374028, 37450.25099498022, 2834.5323021701392, 2849.7190522796236, 2908.287469569969, 2963.7925345225844, 3017.909462716122, 28095.0, 28242.85878570594, 28375.858120709472, 28479.857600711865, 28750.281242968886, 3350.5644266245477, 3402.557667503209, 3451.6720911513366, 3454.726802665741, 3537.0626783902285, 213599.0, 216445.99999999843, 217194.0, 217504.0, 218146.0, 51391.74304128456, 51712.0, 51786.741066294424, 52017.219741703906, 52026.0, 57921.42078579245, 58107.0, 58262.70868645715, 58864.41135588675, 58898.11652825211, 11461.942690286494, 11616.361100139404, 11637.88362116385, 11639.53441862316, 11695.473703683354, 8539.871901921477, 8541.743747687578, 8550.102239264912, 8550.914490855012, 8567.74296771098, 18797.718034229496, 19158.13788379526, 19276.132574034204, 19306.90346548258, 19343.516412089528, 7597.430192735567, 7657.272559106876, 7739.993800805859, 7792.961035194901, 7841.882371764428, 860.3418384935529, 895.4671970177734, 915.231205787142, 981.9361741486781, 1029.7528593137592, 25412.237632871045, 25614.359641009123, 25674.486510270064, 25815.483690326088, 25897.741022589533, 896.5293221058996, 940.5673390240429, 1020.7448137965508, 1033.8449232615017, 1039.2828948025838, 13886.375113119933, 14290.57128286153, 14564.0, 14736.705265894836, 14886.627834304229, 327350.0, 328981.0, 330739.8093104902, 330887.0, 331885.0, 47892.0, 48001.0, 48134.518654813706, 48177.75911120422, 48205.51794482081, 1187.9465424055766, 1200.4297958469658, 1219.5792451604182, 1237.5359240284893, 1239.6776838022179, 27163.0, 27282.317942051606, 27491.86254068717, 28125.437491250468, 28308.009219677213, 40157.77948866629, 40157.79921100376, 40434.39348409835, 40485.59514404936, 40511.594884050784, 248827.0, 252027.0, 252679.0, 252700.0, 253066.0, 29469.705302947554, 41443.0, 41946.16107677768, 42696.78651606722, 42747.57252427436, 38192.23615527618, 39011.6098839008, 39170.0, 39438.80280598579, 40170.0, 33661.15847103842, 34128.829355853064, 34192.829035855655, 34621.30757384788, 35367.0, 35664.28671426505, 36449.088772780895, 36900.0, 37095.44356834596, 37328.0, 35075.82462087673, 35879.64120358763, 36137.0, 36243.09392265109, 36741.816290918374, 34156.658433415345, 34940.82529587336, 35635.46546801852, 35930.8203458981, 36093.819530902176, 25007.499850003263, 25115.246542603752, 25411.491770164863, 25426.018132248108, 25710.61434078453], "unit": "ms", "name": "ext.html", "value": 17252.85537485854}, {"lowerIsBetter": false, "replicates": [310.7467414057543, 317.89668357783717, 320.220263657993, 320.2681871922657, 323.8623584976386, 14448.277586120692, 14934.25328733563, 15339.616509587251, 15521.534353969399, 16382.098984555845, 8380.748577542683, 8424.873626895585, 8434.40959132861, 8437.70468033619, 8541.4448060876, 4335.436393268878, 4425.690201685883, 4430.26900561407, 4447.243968525342, 4467.709598876079, 4444.577765112325, 4456.286994080948, 4459.219636563588, 6321.273053598826, 6433.806985790434, 6419.51853610981, 6423.614583125004, 6426.132472116275, 6433.7104830282515, 6444.677766111699, 6449.290578036413, 6683.164604424447, 6687.699053542602, 6712.5301228913995, 6720.798376048726, 6125.448709616111, 6168.907466388007, 6407.391297826699, 6430.807075787734, 6431.292557818636, 20391.184352625878, 20735.792642073688, 20867.582648346946, 20881.26915557948, 21202.939853007443, 1818.4181062060145, 1873.5784448498978, 1944.1542928826007, 1958.608278344337, 1976.6837306030966, 13104.672383190402, 13184.274864882427, 13254.035683942167, 13336.933315333457, 13859.514916977958, 1827.1138497828542, 1868.0, 1871.737956686065, 1911.8757280776845, 1924.201456395594, 57535.71232143854, 63085.36914630841, 65856.0, 66504.3349566503, 67216.32783672199, 15588.298526566332, 15748.448804291795, 15782.60543486399, 15793.289301981438, 15794.131322777128, 10659.680209593724, 10908.454577271104, 23658.171963981178, 23703.644445333335, 23791.7620823793, 6085.300190478151, 6229.56393052482, 6242.1261023456755, 6359.0, 6473.381654586354, 5905.261842269716, 5915.1718759373725, 5994.130851026577, 6036.034234522455, 6070.726817293233, 4024.4566983457444, 4027.1140349123148, 4030.1939612077704, 4032.1330913853662, 4048.6356227939627, 1436.676747731752, 1592.9203539822963, 1672.5651330653875, 1677.7231756759998, 1695.626962068343, 831.7338451695521, 886.2156991062956, 968.8982656821073, 969.2682025071026, 993.965211217604, 15220.467283645019, 15252.0, 15802.209889505479, 15894.68210635804, 16292.837071629132, 837.4514692876054, 883.650957871637, 902.8194361127669, 905.6875377994581, 940.1585580905188, 8904.8664270036, 8926.73219803407, 9177.03641117673, 9294.0, 9294.442333460014, 528537.0, 531434.0, 533089.0, 539664.0, 545650.0, 68932.655336723, 73786.0, 73799.63100184465, 73855.26144738591, 74025.25974740292, 1024.2267088348249, 1082.7996820588216, 1134.7276653603242, 1141.7316930521322, 1146.4095990564865, 13537.323133843072, 13782.310884455537, 13988.230647314496, 14197.574072777834, 14368.497102601359, 31178.22054448657, 32268.35463290768, 33286.66713332836, 33671.0, 33854.492182616785, 47138.76430617825, 47833.52166478291, 50414.2437863425, 51750.0, 51928.22107668313, 13884.375203115682, 14063.156210626987, 14316.427342906167, 14326.641833954234, 14495.637609059437, 17089.14554272306, 17639.118044098, 17681.823181768017, 17846.19692113884, 17884.55288617795, 14153.43386264579, 14175.503857364944, 14430.639234019234, 14874.776878346616, 15351.309191086651, 13613.0, 14589.781153282496, 14599.416023359372, 14633.195174265093, 15184.544463666107, 14071.366788494746, 14082.225477598831, 14383.640408989859, 14710.63223419423, 14750.63123421923, 13676.0, 13733.0, 13779.517716879862, 13872.583822485341, 13900.72198556003, 14402.279886005448, 14685.85314146845, 14721.631959201106, 14851.480198193012, 15063.47277845314], "unit": "ms", "name": "jquery.html", "value": 8989.893462674336}, {"lowerIsBetter": false, "replicates": [1464.370320762072, 1595.6649103688226, 1626.3494602159142, 1631.4616176661702, 1671.2061770658938, 6314.116023756677, 6367.904481432783, 6689.364510371507, 6783.864322713549, 6787.524873258873, 6614.140161778962, 6616.206055273362, 6692.531522793406, 6695.765648202314, 6725.630090345029, 1927.5759332946764, 1931.980680193194, 1942.8154325339142, 1950.0347328072553, 1951.5511432370492, 1974.5458544534765, 2008.8694234874758, 2010.286348346338, 2012.3258708332726, 2018.5962807438498, 1904.5048287445225, 1920.2127127877573, 1928.151613290155, 1972.9112189951486, 1972.9901350493228, 1942.9417117486498, 1968.2815772243027, 1969.1335812242567, 1969.6356174107837, 1971.7239586457908, 1947.6883698608297, 1988.7514060742408, 1988.9602207955759, 1995.5310502032012, 1995.6308083004546, 6568.376004279586, 6689.03009063683, 6689.264180940093, 6691.59850408977, 6695.3304669533145, 3784.678302344304, 3863.961360386388, 3864.3816989281863, 3873.0317420644838, 3884.164904545508, 2553.208505363343, 2565.563854144781, 2599.8180127391092, 2638.722934091931, 2641.392479729673, 872.6945569050845, 1719.9017199017185, 1726.1800644693797, 1728.2482120277593, 1745.8874761538555, 8546.273566746833, 8690.174433428814, 8708.303335733126, 8712.21590056898, 8714.694985675535, 3353.832308384571, 3355.5134505497053, 3393.9660603394145, 3395.422778127724, 3404.4042292598697, 7156.534825236343, 7156.82107947295, 7161.0, 7170.713171473083, 7182.317679820513, 3722.664960153545, 3725.9068523287133, 3733.14137748314, 3745.8314375852606, 3748.0629842539365, 3404.097914052778, 3412.4369479036177, 3426.9828650856584, 3428.177237462991, 3455.188030812757, 2942.6321709786275, 2947.5873377726707, 2956.556516522539, 2969.1834745445176, 2982.8359440230997, 856.6444925356033, 859.3984211052289, 870.0559892516691, 871.2637821041337, 871.5119533061505, 909.5770466733001, 918.2745630951607, 935.2517985611483, 963.2631037256505, 1146.8451759012594, 6110.052941794029, 6152.0, 6176.81469555914, 6182.969085154546, 6188.659623720739, 1010.3836659637615, 1014.700663304327, 1031.9845202321972, 1035.803197392493, 1057.0961827637414, 5080.949190508121, 5086.669366491166, 5124.205748109049, 5126.461721519261, 5127.743612819344, 7588.582627955405, 7677.731279405194, 7710.228977102357, 7816.960915195501, 7871.173526779606, 7757.92242077572, 7771.883421748678, 7794.103678077094, 7799.610019499002, 7846.529208247409, 6294.181756371642, 6329.936700633027, 6345.49236061114, 6357.809265722036, 6358.141650877073, 6043.36544662804, 6159.538034647509, 6166.105914642441, 6178.474829639531, 6192.752289908353, 7015.894761578683, 7113.518483355453, 7143.785686429415, 7171.354578087997, 7274.927250727636, 7153.248908864494, 7251.8187045324285, 7261.891071633824, 7339.119305683139, 7379.114506259283, 5729.9713501432225, 5762.740676669476, 5764.164196191445, 5784.190213370216, 5791.53667706574, 6172.5679202457195, 6189.257289125154, 6218.347073557211, 6225.8132256032395, 6233.283172435228, 5931.288245410578, 6123.173371594778, 6154.969225153845, 6212.937870621236, 6228.906566401417, 5099.184130539096, 5335.653182543122, 5516.42781807183, 5639.830805075854, 5717.256756621613, 5827.912581311199, 6029.57792954489, 6046.244219472566, 6089.451949324582, 6126.111713801385, 5738.340090889601, 5749.7125143741805, 5761.078227483583, 5802.158686990447, 5834.416558344132, 5683.658980461186, 5685.175649530877, 5699.344575373885, 5700.486956173964, 5730.627509211888], "unit": "ms", "name": "mootools.html", "value": 3864.1801605186342}, {"lowerIsBetter": false, "replicates": [285.7642444982889, 293.47614508103027, 294.386204763069, 298.75800601512776, 299.9755833827479, 5512.393636699965, 5591.245181900442, 5605.971970140149, 5619.466150715686, 5665.660060396379, 5534.418886016971, 5545.805896793613, 5554.50009499146, 5554.527865131458, 5566.86082847929, 4327.069680018795, 4327.112941846914, 4327.740335579875, 4330.873972767087, 4334.934975975363, 4140.896477588054, 4250.723702959298, 4263.744175349473, 4276.550962148976, 4299.0, 4211.43145675333, 4215.220184265905, 4221.32458806591, 4240.0, 4256.148770245948, 4226.1547690461875, 4231.301835197204, 4242.278812601865, 4245.617894389489, 4250.04374015847, 3663.065918190871, 3669.6697297243377, 3670.0457880950876, 3672.6510981456986, 3672.8430544378434, 5184.611154163415, 5292.788288468457, 5319.840404787863, 5325.227841962933, 5337.718947452622, 4855.708657480527, 4858.587020103296, 4866.489018653026, 4867.050925069613, 4890.168671325883, 5814.098814683731, 5834.6790926499025, 5838.328592211908, 5843.181954526327, 5857.794977175821, 3967.7420967637013, 3968.8809335719975, 3968.980155099206, 3974.920501589952, 3980.2636512245326, 5964.7912323068485, 6071.817845464643, 6141.324454310023, 6175.907361389628, 6182.690865456754, 3984.6053881141947, 4005.5794141615293, 4015.3374693175883, 4018.3168861293652, 4024.7786371749835, 4066.34938409853, 4070.674346052309, 4071.877843664695, 4077.5922407758985, 4085.611866872642, 4751.904961900743, 4767.0, 4767.094252092161, 4776.283557466339, 4778.235482322882, 5722.341930677942, 5863.501602363762, 5879.441453061952, 5889.146073819272, 5893.5579831512805, 1436.4541474239932, 1437.2813593203398, 1439.7336492748875, 1440.625437386287, 1440.7262620102147, 923.5197697197419, 976.2531663277598, 977.4721650308895, 981.1660088924357, 994.945278009702, 5037.773300201499, 5084.898302033938, 5093.694378337312, 5112.795488180431, 5115.948840511622, 5955.52355811534, 6108.938910610926, 6109.480694140959, 6114.0, 6119.265688117365, 5106.744662766847, 5129.820456284012, 5132.255822905658, 5134.845954621367, 5149.124648809711, 3266.2161081340782, 3312.519684645713, 3313.188268874141, 3315.5689760331484, 3330.167458135466, 5781.103928890944, 5799.9130013049835, 5801.12983052537, 5811.2445382100905, 5814.360420353758, 6143.692815359214, 6331.873362532723, 6334.1765570475545, 6343.651099189497, 6357.523185761086, 5759.2512973313205, 5788.507976821933, 5795.275590551181, 5801.9129713054335, 5806.0, 6153.66154861469, 6155.784547540815, 6158.969205153946, 6162.22972128484, 6167.629942203482, 5892.970535147297, 5968.194293770285, 6003.549733770072, 6006.429389208019, 6009.939900600938, 5777.826665200051, 5781.884362312814, 5784.652920824596, 5785.537157027344, 5790.218320526675, 4026.879193624196, 4032.858849940238, 4038.374052021941, 4052.9392059119727, 4055.736377135595, 5972.880542389041, 6086.756529738761, 6087.69561521931, 6135.07973803933, 6135.631862088289, 5855.0, 5855.063189889597, 5878.030125029322, 5889.94110058894, 5897.174395584536, 5874.471297583238, 5884.32330282023, 5887.146363777143, 5889.293284805851, 5889.646621202742, 5764.596478246483, 5766.163906233656, 5770.163326317745, 5782.45066718661, 5790.10253410722, 5700.686462244616, 5831.504322132666, 5844.561657875592, 5859.414058594107, 5890.381509941394, 5783.566232532493, 5801.883962320646, 5808.477237048686, 5808.651480911159, 5817.94182058174], "unit": "ms", "name": "prototype.html", "value": 4355.586523334494}, {"lowerIsBetter": false, "replicates": [691.6818263598744, 762.8207371267748, 778.0585491555221, 778.3423007558613, 787.2599756229145, 10553.73615659608, 10905.83641245382, 10941.890581094196, 11229.719257018578, 11491.425428728571, 12548.749025019493, 12566.18319809214, 12617.0, 12629.747405051894, 12666.62000139995, 749.2769477454256, 754.7886591754318, 755.2787088330645, 767.8349154931689, 768.0974854545887, 774.0672489649959, 778.5640041576735, 778.8052986753312, 782.3428320211021, 783.6786917363881, 791.8812178173291, 796.6016991504248, 797.5214871077336, 800.671724592917, 800.7437619961614, 790.4861839804116, 792.627465091409, 792.6789650191681, 792.9286364227247, 795.2643804480861, 587.8030859662018, 588.7350692188489, 589.2487078974342, 589.4047012517345, 590.7607418995314, 10993.230473866832, 11114.666560003132, 11129.109671226282, 11133.276337038147, 11172.162087843444, 10719.732006699816, 10800.513976870981, 11031.944840275828, 11152.0, 11247.100231981422, 9133.588988495534, 9175.632974681004, 9274.536273186313, 9429.858552121723, 9626.326157169002, 3223.09753269085, 3224.4679627861374, 3275.852586633607, 3290.68738469845, 3297.653746356622, 41699.999999999694, 42065.78967105145, 42206.15587688229, 42222.366664500056, 42298.0, 7480.551166930001, 7580.279873412017, 7612.7716168515035, 7617.542947423172, 7625.199354067854, 13061.738765224642, 13224.140430871963, 13302.800457993138, 16281.67436651284, 16427.342906283615, 6422.775202867877, 6555.475561955032, 6595.043718660863, 6606.636634985122, 6635.635040072746, 3725.403935370328, 3744.8314825832904, 3820.904477388032, 3841.3277676407074, 3898.9610103899167, 2529.8355606885493, 2549.0695895998197, 2560.4111054457208, 2579.252016915111, 2588.352911772057, 469.5609605019318, 478.9185838407479, 480.4426864836773, 482.2043628013735, 492.3550149304423, 465.71591329289106, 476.5520410813824, 478.2754127496845, 491.95818355439474, 583.3291714528326, 7052.753153639598, 7365.705371785176, 7635.0, 7712.383009359238, 7858.685652573948, 441.4944888103104, 478.8826737449347, 508.3239291741974, 590.2179612014013, 594.8602078511547, 3595.0, 3675.1783571723454, 3683.9447408288897, 3751.099736063325, 3820.121372084436, 53045.469545304055, 53731.0, 53733.92532149335, 53927.46072539303, 54017.729911350194, 47689.76155119202, 47792.22077792193, 47991.0, 48237.517624823304, 48481.757591212525, 44345.77827110844, 44450.77774611106, 44683.10633787306, 45166.32250516245, 45938.0, 7828.491148075357, 7870.685172593032, 8323.126071762377, 8381.203785640355, 8396.076431592397, 33026.33947321088, 33131.0, 33307.83346083254, 33513.83243083769, 33600.0, 41256.0, 42543.0, 42699.14601707886, 43316.566834332516, 43825.0, 9662.613495460102, 9834.803303933739, 9882.50587470638, 10016.0, 10168.084872361524, 10919.508622112184, 10949.726256843642, 11001.559937602406, 11234.101271898391, 11322.26405283654, 10207.234457415872, 10272.0, 10448.32085914413, 10473.162147028068, 10624.84062739075, 9685.225181985283, 9714.562844672148, 9761.219102471927, 9985.1512621428, 10033.548490317808, 9164.770880728036, 10411.167106631603, 10797.136229101496, 11391.886081139082, 11459.942700286778, 7996.6401511930935, 8222.424430289822, 8920.955395222982, 9017.504037278013, 9210.309226807882, 8587.184217499327, 8774.429662071945, 8810.955945220232, 8906.643734250558, 9038.0], "unit": "ms", "name": "yui.html", "value": 5640.154400589033}], "name": "dromaeo_css", "value": 6382.912740485142}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 113.0, 112.0, 113.0, 127.0, 113.0, 114.0, 113.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 114.2}, {"lowerIsBetter": true, "replicates": [158.0, 132.0, 156.0, 164.0, 133.0, 171.0, 154.0, 133.0, 170.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [165.0, 167.0, 164.0, 163.0, 161.0, 167.0, 171.0, 164.0, 166.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 165.0}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 73.0, 71.0, 76.0, 140.0, 72.0, 73.0, 73.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 134.0, 93.0, 95.0, 95.0, 131.0, 93.0, 95.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 105.8}, {"lowerIsBetter": true, "replicates": [111.0, 111.0, 109.0, 110.0, 109.0, 109.0, 110.0, 111.0, 111.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 148.0, 148.0, 149.0, 149.0, 150.0, 148.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 97.0, 95.0, 99.0, 96.0, 99.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 75.0, 75.0, 76.0, 77.0, 75.0, 79.0, 75.0, 74.0], "unit": "ms", "name": "json-parse-financial", "value": 75.4}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 70.0, 69.0, 70.0, 70.0, 69.0, 69.0, 70.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 84.0, 84.0, 83.0, 84.0, 83.0, 84.0, 83.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [136.0, 128.0, 127.0, 133.0, 137.0, 136.0, 129.0, 125.0, 122.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 130.3}, {"lowerIsBetter": true, "replicates": [151.0, 147.0, 149.0, 144.0, 147.0, 147.0, 137.0, 149.0, 148.0, 147.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.6}, {"lowerIsBetter": true, "replicates": [86.0, 71.0, 70.0, 71.0, 71.0, 70.0, 71.0, 72.0, 68.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.9}], "name": "kraken", "value": 1546.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.27868307283006], "unit": "score", "name": "Richards", "value": 212.306228}, {"lowerIsBetter": false, "replicates": [183.75597206909225], "unit": "score", "name": "DeltaBlue", "value": 359.81415599999985}, {"lowerIsBetter": false, "replicates": [277.54648903691367], "unit": "score", "name": "Encrypt", "value": 959.0501430000003}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1072.961373390558], "unit": "score", "name": "RayTrace", "value": 689.6697479999999}, {"lowerIsBetter": false, "replicates": [702.9494382022472], "unit": "score", "name": "Earley", "value": 948.0952167832171}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [25641.02564102564], "unit": "score", "name": "RegExp", "value": 35.52841499999999}, {"lowerIsBetter": false, "replicates": [621.1180124223603], "unit": "score", "name": "Splay", "value": 131.20050999999998}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21373.335818412794}]} 04:47:19 INFO - RETURN: dromaeo_css: 6382.91 04:47:19 INFO - RETURN: kraken: 1546.70 04:47:19 INFO - RETURN: v8_7: 21373.34 04:47:19 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21373.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1546.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6382.91"}}} 04:47:19 INFO - Return code: 0 04:47:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:47:19 INFO - # TBPL SUCCESS # 04:47:19 INFO - Running post-action listener: _resource_record_post_action 04:47:19 INFO - Running post-run listener: _resource_record_post_run 04:47:20 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 501579776; Read time: 8; Write time: 395040 04:47:20 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 230326272; Read time: 0; Write time: 277428 04:47:20 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 271253504; Read time: 8; Write time: 117612 04:47:20 INFO - Running post-run listener: _upload_blobber_files 04:47:20 INFO - Blob upload gear active. 04:47:20 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:47:20 INFO - Copying logs to upload dir... 04:47:20 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1267.669022 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-02 04:47:20.645732) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 04:47:20.649470) ========= 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=e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626 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.009976 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.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 04:47:20.701301) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 04:47:20.701626) ========= 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=e10134013339c31d8d0c4708000001d6-1449059170.561708-1779838626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 04:47:20.752278) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 04:47:20.752802) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 04:47:20.753319) ========= ========= Total master_lag: 0.21 =========