builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-024 starttime: 1450293144.07 results: success (0) buildid: 20151216101738 builduid: 131c8fcbd071409aad9ba77d9760014b revision: ebabcb64dab69728255088dffb73c15355ff1f21 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 11:12:24.065584) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 11:12:24.066305) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 11:12:24.066609) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006458 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 11:12:24.092161) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 11:12:24.092476) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 11:12:24.149806) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:12:24.150068) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:12:24.210137) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 11:12:24.210419) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 11:12:24.210799) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 11:12:24.211080) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 11:12:24-- 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% 220M=0s 2015-12-16 11:12:25 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=1.185001 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 11:12:25.417522) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:12:25.417857) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019087 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:12:25.467736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:12:25.468218) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ebabcb64dab69728255088dffb73c15355ff1f21 --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 ebabcb64dab69728255088dffb73c15355ff1f21 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 11:12:25,597 truncating revision to first 12 chars 2015-12-16 11:12:25,597 Setting DEBUG logging. 2015-12-16 11:12:25,597 attempt 1/10 2015-12-16 11:12:25,597 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ebabcb64dab6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 11:12:25,852 unpacking tar archive at: fx-team-ebabcb64dab6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.530580 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:12:26.012220) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 11:12:26.012555) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 11:12:26.023106) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 11:12:26.023497) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 11:12:26.023956) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-16 11:12:26.024244) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:12:26 INFO - MultiFileLogger online at 20151216 11:12:26 in /builds/slave/test 11:12:26 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 11:12:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:12:26 INFO - {'append_to_log': False, 11:12:26 INFO - 'base_work_dir': '/builds/slave/test', 11:12:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:12:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:12:26 INFO - 'branch': 'Fx-Team-Non-PGO', 11:12:26 INFO - 'buildbot_json_path': 'buildprops.json', 11:12:26 INFO - 'config_files': ('talos/linux_config.py',), 11:12:26 INFO - 'default_actions': ('clobber', 11:12:26 INFO - 'read-buildbot-config', 11:12:26 INFO - 'download-and-extract', 11:12:26 INFO - 'populate-webroot', 11:12:26 INFO - 'create-virtualenv', 11:12:26 INFO - 'install', 11:12:26 INFO - 'run-tests'), 11:12:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:12:26 INFO - 'download_minidump_stackwalk': True, 11:12:26 INFO - 'download_symbols': 'ondemand', 11:12:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:12:26 INFO - 'tooltool.py': '/tools/tooltool.py', 11:12:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:12:26 INFO - '/tools/misc-python/virtualenv.py')}, 11:12:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:12:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:12:26 INFO - 'installer_path': 'installer.exe', 11:12:26 INFO - 'log_level': 'info', 11:12:26 INFO - 'log_name': 'talos', 11:12:26 INFO - 'log_to_console': True, 11:12:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:12:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:12:26 INFO - 'opt_config_files': (), 11:12:26 INFO - 'pip_index': False, 11:12:26 INFO - 'sps_profile': False, 11:12:26 INFO - 'sps_profile_interval': 0, 11:12:26 INFO - 'suite': 'dromaeojs-e10s', 11:12:26 INFO - 'system_bits': '64', 11:12:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:12:26 INFO - 'title': 'talos-linux64-ix-024', 11:12:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:12:26 INFO - 'use_talos_json': True, 11:12:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:12:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:12:26 INFO - 'work_dir': 'build'} 11:12:26 INFO - ##### 11:12:26 INFO - ##### Running clobber step. 11:12:26 INFO - ##### 11:12:26 INFO - Running pre-action listener: _resource_record_pre_action 11:12:26 INFO - Running main action method: clobber 11:12:26 INFO - rmtree: /builds/slave/test/build 11:12:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:12:27 INFO - Running post-action listener: _resource_record_post_action 11:12:27 INFO - ##### 11:12:27 INFO - ##### Running read-buildbot-config step. 11:12:27 INFO - ##### 11:12:27 INFO - Running pre-action listener: _resource_record_pre_action 11:12:27 INFO - Running main action method: read_buildbot_config 11:12:27 INFO - Using buildbot properties: 11:12:27 INFO - { 11:12:27 INFO - "properties": { 11:12:27 INFO - "buildnumber": 576, 11:12:27 INFO - "product": "firefox", 11:12:27 INFO - "script_repo_revision": "production", 11:12:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:12:27 INFO - "repository": "", 11:12:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 11:12:27 INFO - "buildid": "20151216101738", 11:12:27 INFO - "slavename": "talos-linux64-ix-024", 11:12:27 INFO - "pgo_build": "False", 11:12:27 INFO - "basedir": "/builds/slave/test", 11:12:27 INFO - "project": "", 11:12:27 INFO - "platform": "ubuntu64_hw", 11:12:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:12:27 INFO - "slavebuilddir": "test", 11:12:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:12:27 INFO - "branch": "fx-team", 11:12:27 INFO - "repo_path": "integration/fx-team", 11:12:27 INFO - "stage_platform": "linux64", 11:12:27 INFO - "builduid": "131c8fcbd071409aad9ba77d9760014b", 11:12:27 INFO - "revision": "ebabcb64dab69728255088dffb73c15355ff1f21" 11:12:27 INFO - }, 11:12:27 INFO - "sourcestamp": { 11:12:27 INFO - "repository": "", 11:12:27 INFO - "hasPatch": false, 11:12:27 INFO - "project": "", 11:12:27 INFO - "branch": "fx-team-linux64-talos", 11:12:27 INFO - "changes": [ 11:12:27 INFO - { 11:12:27 INFO - "category": null, 11:12:27 INFO - "files": [ 11:12:27 INFO - { 11:12:27 INFO - "url": null, 11:12:27 INFO - "name": "https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 11:12:27 INFO - } 11:12:27 INFO - ], 11:12:27 INFO - "repository": "", 11:12:27 INFO - "rev": "ebabcb64dab69728255088dffb73c15355ff1f21", 11:12:27 INFO - "who": "bgrinstead@mozilla.com", 11:12:27 INFO - "when": 1450293061, 11:12:27 INFO - "number": 7367652, 11:12:27 INFO - "comments": "Bug 1055333 - Enable last styleeditor e10s tests;r=ejpbruel", 11:12:27 INFO - "project": "", 11:12:27 INFO - "at": "Wed 16 Dec 2015 11:11:01", 11:12:27 INFO - "branch": "fx-team-linux64-talos", 11:12:27 INFO - "revlink": "", 11:12:27 INFO - "properties": [ 11:12:27 INFO - [ 11:12:27 INFO - "buildid", 11:12:27 INFO - "20151216101738", 11:12:27 INFO - "Change" 11:12:27 INFO - ], 11:12:27 INFO - [ 11:12:27 INFO - "builduid", 11:12:27 INFO - "131c8fcbd071409aad9ba77d9760014b", 11:12:27 INFO - "Change" 11:12:27 INFO - ], 11:12:27 INFO - [ 11:12:27 INFO - "pgo_build", 11:12:27 INFO - "False", 11:12:27 INFO - "Change" 11:12:27 INFO - ] 11:12:27 INFO - ], 11:12:27 INFO - "revision": "ebabcb64dab69728255088dffb73c15355ff1f21" 11:12:27 INFO - } 11:12:27 INFO - ], 11:12:27 INFO - "revision": "ebabcb64dab69728255088dffb73c15355ff1f21" 11:12:27 INFO - } 11:12:27 INFO - } 11:12:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 11:12:27 INFO - Running post-action listener: _resource_record_post_action 11:12:27 INFO - ##### 11:12:27 INFO - ##### Running download-and-extract step. 11:12:27 INFO - ##### 11:12:27 INFO - Running pre-action listener: _resource_record_pre_action 11:12:27 INFO - Running main action method: download_and_extract 11:12:27 INFO - mkdir: /builds/slave/test/build/tests 11:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:27 INFO - https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:12:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/test_packages.json 11:12:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/test_packages.json 11:12:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:12:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:12:30 INFO - Downloaded 1302 bytes. 11:12:30 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:12:30 INFO - Using the following test package requirements: 11:12:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:12:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:12:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:30 INFO - u'jsshell-linux-x86_64.zip'], 11:12:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:12:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:12:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:12:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:12:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:12:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:12:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:12:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:30 INFO - https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:12:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:12:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:12:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:12:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:12:32 INFO - Downloaded 21870297 bytes. 11:12:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:12:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:12:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:12:33 INFO - Return code: 0 11:12:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:12:33 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')]} 11:12:33 INFO - https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:12:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:12:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:12:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:12:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:12:35 INFO - Downloaded 21870297 bytes. 11:12:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:12:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:12:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:12:36 INFO - Return code: 0 11:12:36 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')]} 11:12:36 INFO - https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:12:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:12:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:12:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:12:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:12:37 INFO - Downloaded 11132052 bytes. 11:12:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 11:12:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:12:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:12:37 INFO - Return code: 0 11:12: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')]} 11:12:37 INFO - https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:12:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:12:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:12:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:12:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:12:38 INFO - Downloaded 57775015 bytes. 11:12:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:12:38 INFO - mkdir: /builds/slave/test/properties 11:12:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:12:38 INFO - Writing to file /builds/slave/test/properties/build_url 11:12:38 INFO - Contents: 11:12:38 INFO - build_url:https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:12:38 INFO - Running post-action listener: _resource_record_post_action 11:12:38 INFO - Running post-action listener: set_extra_try_arguments 11:12:38 INFO - ##### 11:12:38 INFO - ##### Running populate-webroot step. 11:12:38 INFO - ##### 11:12:38 INFO - Running pre-action listener: _resource_record_pre_action 11:12:38 INFO - Running main action method: populate_webroot 11:12:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:12:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:12:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:12:39 INFO - '--tppagecycles', 11:12:39 INFO - '7'], 11:12:39 INFO - 'tests': ['tsvgm']}}, 11:12:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:12:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:12:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:12:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:12:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:12:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:12:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:39 INFO - 'talos_options': ['--e10s'], 11:12:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:39 INFO - 'tests': ['damp', 'tps']}, 11:12:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:39 INFO - 'talos_options': ['--e10s'], 11:12:39 INFO - 'tests': ['damp', 'tps']}, 11:12:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:12:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:12:39 INFO - 'other': {'tests': ['a11yr', 11:12:39 INFO - 'ts_paint', 11:12:39 INFO - 'tpaint', 11:12:39 INFO - 'sessionrestore', 11:12:39 INFO - 'sessionrestore_no_auto_restore']}, 11:12:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:12:39 INFO - 'tests': ['a11yr', 11:12:39 INFO - 'ts_paint', 11:12:39 INFO - 'tpaint', 11:12:39 INFO - 'sessionrestore', 11:12:39 INFO - 'sessionrestore_no_auto_restore']}, 11:12:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:12:39 INFO - 'tests': ['a11yr', 11:12:39 INFO - 'ts_paint', 11:12:39 INFO - 'tpaint', 11:12:39 INFO - 'sessionrestore', 11:12:39 INFO - 'sessionrestore_no_auto_restore']}, 11:12:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:12:39 INFO - 'tests': ['a11yr', 11:12:39 INFO - 'ts_paint', 11:12:39 INFO - 'tpaint', 11:12:39 INFO - 'sessionrestore', 11:12:39 INFO - 'sessionrestore_no_auto_restore']}, 11:12:39 INFO - 'other_l64': {'tests': ['a11yr', 11:12:39 INFO - 'ts_paint', 11:12:39 INFO - 'tpaint', 11:12:39 INFO - 'sessionrestore', 11:12:39 INFO - 'sessionrestore_no_auto_restore']}, 11:12:39 INFO - 'other_nol64': {'tests': ['a11yr', 11:12:39 INFO - 'ts_paint', 11:12:39 INFO - 'tpaint', 11:12:39 INFO - 'sessionrestore', 11:12:39 INFO - 'sessionrestore_no_auto_restore']}, 11:12:39 INFO - 'svgr': {'tests': ['tsvgx', 11:12:39 INFO - 'tsvgr_opacity', 11:12:39 INFO - 'tart', 11:12:39 INFO - 'tscrollx', 11:12:39 INFO - 'cart']}, 11:12:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:12:39 INFO - 'tests': ['tsvgx', 11:12:39 INFO - 'tsvgr_opacity', 11:12:39 INFO - 'tart', 11:12:39 INFO - 'tscrollx', 11:12:39 INFO - 'cart']}, 11:12:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:39 INFO - 'tests': ['tp5o']}, 11:12:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:39 INFO - 'talos_options': ['--e10s'], 11:12:39 INFO - 'tests': ['tp5o']}, 11:12:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:39 INFO - 'talos_options': ['--xperf_path', 11:12:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:39 INFO - 'tests': ['tp5n']}, 11:12:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:39 INFO - 'talos_options': ['--e10s', 11:12:39 INFO - '--xperf_path', 11:12:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:39 INFO - 'tests': ['tp5n']}}, 11:12:39 INFO - 'talos.zip': {'path': '', 11:12:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:12:39 INFO - Running post-action listener: _resource_record_post_action 11:12:39 INFO - ##### 11:12:39 INFO - ##### Running create-virtualenv step. 11:12:39 INFO - ##### 11:12:39 INFO - Running pre-action listener: _resource_record_pre_action 11:12:39 INFO - Running main action method: create_virtualenv 11:12:39 INFO - Creating virtualenv /builds/slave/test/build/venv 11:12:39 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 11:12:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:12:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:12:39 INFO - Using real prefix '/usr' 11:12:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:12:39 INFO - Installing distribute.............................................................................................................................................................................................done. 11:12:41 INFO - Installing pip.................done. 11:12:41 INFO - Return code: 0 11:12:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff75059af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2972240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a010b0>, '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 0x2a01fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041', '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 11:12: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', 'pip>=1.5'] in /builds/slave/test/build 11:12: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 pip>=1.5 11:12:41 INFO - Using env: {'DISPLAY': ':0', 11:12:41 INFO - 'HOME': '/home/cltbld', 11:12:41 INFO - 'LANG': 'en_US.UTF-8', 11:12:41 INFO - 'LANGUAGE': 'en_US:en', 11:12:41 INFO - 'LOGNAME': 'cltbld', 11:12:41 INFO - 'MAIL': '/var/mail/cltbld', 11:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:41 INFO - 'MOZ_NO_REMOTE': '1', 11:12:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:41 INFO - 'NO_EM_RESTART': '1', 11:12:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:41 INFO - 'PWD': '/builds/slave/test', 11:12:41 INFO - 'SHELL': '/bin/bash', 11:12:41 INFO - 'SHLVL': '1', 11:12:41 INFO - 'TERM': 'linux', 11:12:41 INFO - 'TMOUT': '86400', 11:12:41 INFO - 'USER': 'cltbld', 11:12:41 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041', 11:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:41 INFO - '_': '/tools/buildbot/bin/python'} 11:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:41 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 11:12:41 INFO - Cleaning up... 11:12:41 INFO - Return code: 0 11:12:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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', '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 0x7ff75059af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2972240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a010b0>, '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 0x2a01fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041', '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 11:12: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', 'psutil>=0.7.1'] in /builds/slave/test/build 11:12: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 psutil>=0.7.1 11:12:41 INFO - Using env: {'DISPLAY': ':0', 11:12:41 INFO - 'HOME': '/home/cltbld', 11:12:41 INFO - 'LANG': 'en_US.UTF-8', 11:12:41 INFO - 'LANGUAGE': 'en_US:en', 11:12:41 INFO - 'LOGNAME': 'cltbld', 11:12:41 INFO - 'MAIL': '/var/mail/cltbld', 11:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:41 INFO - 'MOZ_NO_REMOTE': '1', 11:12:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:41 INFO - 'NO_EM_RESTART': '1', 11:12:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:41 INFO - 'PWD': '/builds/slave/test', 11:12:41 INFO - 'SHELL': '/bin/bash', 11:12:41 INFO - 'SHLVL': '1', 11:12:41 INFO - 'TERM': 'linux', 11:12:41 INFO - 'TMOUT': '86400', 11:12:41 INFO - 'USER': 'cltbld', 11:12:41 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041', 11:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:41 INFO - '_': '/tools/buildbot/bin/python'} 11:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:42 INFO - Downloading/unpacking psutil>=0.7.1 11:12:42 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 11:12:42 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 11:12:42 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 11:12:42 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 11:12:42 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 11:12:42 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 11:12:43 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:12:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:12:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:43 INFO - Installing collected packages: psutil 11:12:43 INFO - Running setup.py install for psutil 11:12:43 INFO - building 'psutil._psutil_linux' extension 11:12:43 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 11:12:44 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 11:12:44 INFO - building 'psutil._psutil_posix' extension 11:12:44 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 11:12:44 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 11:12:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:44 INFO - Successfully installed psutil 11:12:44 INFO - Cleaning up... 11:12:44 INFO - Return code: 0 11:12:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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', '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 0x7ff75059af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2972240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a010b0>, '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 0x2a01fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041', '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 11:12: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:12: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 mozsystemmonitor==0.0.0 11:12:44 INFO - Using env: {'DISPLAY': ':0', 11:12:44 INFO - 'HOME': '/home/cltbld', 11:12:44 INFO - 'LANG': 'en_US.UTF-8', 11:12:44 INFO - 'LANGUAGE': 'en_US:en', 11:12:44 INFO - 'LOGNAME': 'cltbld', 11:12:44 INFO - 'MAIL': '/var/mail/cltbld', 11:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:44 INFO - 'MOZ_NO_REMOTE': '1', 11:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:44 INFO - 'NO_EM_RESTART': '1', 11:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:44 INFO - 'PWD': '/builds/slave/test', 11:12:44 INFO - 'SHELL': '/bin/bash', 11:12:44 INFO - 'SHLVL': '1', 11:12:44 INFO - 'TERM': 'linux', 11:12:44 INFO - 'TMOUT': '86400', 11:12:44 INFO - 'USER': 'cltbld', 11:12:44 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041', 11:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:44 INFO - '_': '/tools/buildbot/bin/python'} 11:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:12:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:12:46 INFO - Installing collected packages: mozsystemmonitor 11:12:46 INFO - Running setup.py install for mozsystemmonitor 11:12:46 INFO - Successfully installed mozsystemmonitor 11:12:46 INFO - Cleaning up... 11:12:46 INFO - Return code: 0 11:12:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:12:46 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')]} 11:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:46 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')]} 11:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:46 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 0x7ff75059af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2972240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a010b0>, '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 0x2a01fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041', '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 11:12:46 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 11:12:46 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 11:12:46 INFO - Using env: {'DISPLAY': ':0', 11:12:46 INFO - 'HOME': '/home/cltbld', 11:12:46 INFO - 'LANG': 'en_US.UTF-8', 11:12:46 INFO - 'LANGUAGE': 'en_US:en', 11:12:46 INFO - 'LOGNAME': 'cltbld', 11:12:46 INFO - 'MAIL': '/var/mail/cltbld', 11:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:46 INFO - 'MOZ_NO_REMOTE': '1', 11:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:46 INFO - 'NO_EM_RESTART': '1', 11:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:46 INFO - 'PWD': '/builds/slave/test', 11:12:46 INFO - 'SHELL': '/bin/bash', 11:12:46 INFO - 'SHLVL': '1', 11:12:46 INFO - 'TERM': 'linux', 11:12:46 INFO - 'TMOUT': '86400', 11:12:46 INFO - 'USER': 'cltbld', 11:12:46 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041', 11:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:46 INFO - '_': '/tools/buildbot/bin/python'} 11:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:46 INFO - Downloading/unpacking blobuploader==1.2.4 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12:48 INFO - Downloading blobuploader-1.2.4.tar.gz 11:12:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:12:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:12:48 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 11:12:48 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 11:12:48 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 11:12:48 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 11:12:48 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 11:12:48 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 11:12:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:12:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:12:48 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 11:12:48 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 11:12:48 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 11:12:48 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 11:12:48 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 11:12:48 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 11:12:49 INFO - Downloading docopt-0.6.1.tar.gz 11:12:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:12:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:12:49 INFO - Installing collected packages: blobuploader, requests, docopt 11:12:49 INFO - Running setup.py install for blobuploader 11:12:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:12:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:12:49 INFO - Running setup.py install for requests 11:12:49 INFO - Running setup.py install for docopt 11:12:49 INFO - Successfully installed blobuploader requests docopt 11:12:49 INFO - Cleaning up... 11:12:49 INFO - Return code: 0 11:12:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:49 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 0x7ff75059af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2972240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a010b0>, '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 0x2a01fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041', '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 11:12:49 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 11:12:49 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 11:12:49 INFO - Using env: {'DISPLAY': ':0', 11:12:49 INFO - 'HOME': '/home/cltbld', 11:12:49 INFO - 'LANG': 'en_US.UTF-8', 11:12:49 INFO - 'LANGUAGE': 'en_US:en', 11:12:49 INFO - 'LOGNAME': 'cltbld', 11:12:49 INFO - 'MAIL': '/var/mail/cltbld', 11:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:49 INFO - 'MOZ_NO_REMOTE': '1', 11:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:49 INFO - 'NO_EM_RESTART': '1', 11:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:49 INFO - 'PWD': '/builds/slave/test', 11:12:49 INFO - 'SHELL': '/bin/bash', 11:12:49 INFO - 'SHLVL': '1', 11:12:49 INFO - 'TERM': 'linux', 11:12:49 INFO - 'TMOUT': '86400', 11:12:49 INFO - 'USER': 'cltbld', 11:12:49 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041', 11:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:49 INFO - '_': '/tools/buildbot/bin/python'} 11:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:49 INFO - Running setup.py (path:/tmp/pip-8L9q9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:49 INFO - Running setup.py (path:/tmp/pip-7Op3Nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:50 INFO - Running setup.py (path:/tmp/pip-oaIWqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:50 INFO - Running setup.py (path:/tmp/pip-N4QHVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:50 INFO - Running setup.py (path:/tmp/pip-ME4bGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:50 INFO - Running setup.py (path:/tmp/pip-E3t8XS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:50 INFO - Running setup.py (path:/tmp/pip-1mqGRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:50 INFO - Running setup.py (path:/tmp/pip-NJ9w2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:50 INFO - Running setup.py (path:/tmp/pip-p_N6Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:50 INFO - Running setup.py (path:/tmp/pip-oHAbEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:50 INFO - Running setup.py (path:/tmp/pip-yi_7UC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:50 INFO - Running setup.py (path:/tmp/pip-5mIo4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:50 INFO - Running setup.py (path:/tmp/pip-uOOUOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:50 INFO - Running setup.py (path:/tmp/pip-Lk8bW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:50 INFO - Running setup.py (path:/tmp/pip-tM7Aug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:50 INFO - Running setup.py (path:/tmp/pip-egoLZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:51 INFO - Running setup.py (path:/tmp/pip-Exaimc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:12:51 INFO - Running setup.py install for manifestparser 11:12:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:12:51 INFO - Running setup.py install for mozcrash 11:12:51 INFO - Running setup.py install for mozdebug 11:12:51 INFO - Running setup.py install for mozdevice 11:12:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:12:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:12:51 INFO - Running setup.py install for mozfile 11:12:51 INFO - Running setup.py install for mozhttpd 11:12:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:12:51 INFO - Running setup.py install for mozinfo 11:12:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:12:51 INFO - Running setup.py install for mozInstall 11:12:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:12:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:12:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:12:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:12:51 INFO - Running setup.py install for mozleak 11:12:52 INFO - Running setup.py install for mozlog 11:12:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:12:52 INFO - Running setup.py install for moznetwork 11:12:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:12:52 INFO - Running setup.py install for mozprocess 11:12:52 INFO - Running setup.py install for mozprofile 11:12:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:12:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:12:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:12:52 INFO - Running setup.py install for mozrunner 11:12:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:12:52 INFO - Running setup.py install for mozscreenshot 11:12:52 INFO - Running setup.py install for moztest 11:12:52 INFO - Running setup.py install for mozversion 11:12:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:12:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:12:52 INFO - Cleaning up... 11:12:52 INFO - Return code: 0 11:12:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:52 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')]} 11:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:52 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')]} 11:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:52 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 0x7ff75059af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2972240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a010b0>, '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 0x2a01fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041', '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 11:12:52 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 11:12:52 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 11:12:52 INFO - Using env: {'DISPLAY': ':0', 11:12:52 INFO - 'HOME': '/home/cltbld', 11:12:52 INFO - 'LANG': 'en_US.UTF-8', 11:12:52 INFO - 'LANGUAGE': 'en_US:en', 11:12:52 INFO - 'LOGNAME': 'cltbld', 11:12:52 INFO - 'MAIL': '/var/mail/cltbld', 11:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:52 INFO - 'MOZ_NO_REMOTE': '1', 11:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:52 INFO - 'NO_EM_RESTART': '1', 11:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:52 INFO - 'PWD': '/builds/slave/test', 11:12:52 INFO - 'SHELL': '/bin/bash', 11:12:52 INFO - 'SHLVL': '1', 11:12:52 INFO - 'TERM': 'linux', 11:12:52 INFO - 'TMOUT': '86400', 11:12:52 INFO - 'USER': 'cltbld', 11:12:52 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041', 11:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:52 INFO - '_': '/tools/buildbot/bin/python'} 11:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:53 INFO - Running setup.py (path:/tmp/pip-wzwenN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:53 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)) 11:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:53 INFO - Running setup.py (path:/tmp/pip-tWfRXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:53 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)) 11:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:53 INFO - Running setup.py (path:/tmp/pip-zIFXbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:53 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)) 11:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:53 INFO - Running setup.py (path:/tmp/pip-_gnxwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:53 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)) 11:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:53 INFO - Running setup.py (path:/tmp/pip-Tn63Hi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:53 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)) 11:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:53 INFO - Running setup.py (path:/tmp/pip-PjW9x3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:53 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)) 11:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:53 INFO - Running setup.py (path:/tmp/pip-BDKLGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:53 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)) 11:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:53 INFO - Running setup.py (path:/tmp/pip-k8YBPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:53 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)) 11:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:53 INFO - Running setup.py (path:/tmp/pip-aRVpWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:53 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)) 11:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:53 INFO - Running setup.py (path:/tmp/pip-j5ArpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:53 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)) 11:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:53 INFO - Running setup.py (path:/tmp/pip-mJGzed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:53 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)) 11:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:53 INFO - Running setup.py (path:/tmp/pip-jMjGZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:53 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)) 11:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:53 INFO - Running setup.py (path:/tmp/pip-W_4kY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:54 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)) 11:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:54 INFO - Running setup.py (path:/tmp/pip-109NN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:54 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)) 11:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:54 INFO - Running setup.py (path:/tmp/pip-X5DVTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:54 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)) 11:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:54 INFO - Running setup.py (path:/tmp/pip-UIRWLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:54 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)) 11:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:54 INFO - Running setup.py (path:/tmp/pip-CYKt_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:54 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)) 11:12:54 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)) 11:12:54 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)) 11:12:54 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)) 11:12:54 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)) 11:12:54 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)) 11:12:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:12:54 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 11:12:54 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 11:12:54 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 11:12:54 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 11:12:54 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 11:12:54 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 11:12:56 INFO - Downloading blessings-1.5.1.tar.gz 11:12:56 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 11:12:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:12:56 INFO - Installing collected packages: blessings 11:12:56 INFO - Running setup.py install for blessings 11:12:56 INFO - Successfully installed blessings 11:12:56 INFO - Cleaning up... 11:12:56 INFO - Return code: 0 11:12:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:12:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:56 INFO - Reading from file tmpfile_stdout 11:12:56 INFO - Current package versions: 11:12:56 INFO - argparse == 1.2.1 11:12:56 INFO - blessings == 1.5.1 11:12:56 INFO - blobuploader == 1.2.4 11:12:56 INFO - docopt == 0.6.1 11:12:56 INFO - manifestparser == 1.1 11:12:56 INFO - mozInstall == 1.12 11:12:56 INFO - mozcrash == 0.16 11:12:56 INFO - mozdebug == 0.1 11:12:56 INFO - mozdevice == 0.47 11:12:56 INFO - mozfile == 1.2 11:12:56 INFO - mozhttpd == 0.7 11:12:56 INFO - mozinfo == 0.9 11:12:56 INFO - mozleak == 0.1 11:12:56 INFO - mozlog == 3.1 11:12:56 INFO - moznetwork == 0.27 11:12:56 INFO - mozprocess == 0.22 11:12:56 INFO - mozprofile == 0.27 11:12:56 INFO - mozrunner == 6.11 11:12:56 INFO - mozscreenshot == 0.1 11:12:56 INFO - mozsystemmonitor == 0.0 11:12:56 INFO - moztest == 0.7 11:12:56 INFO - mozversion == 1.4 11:12:56 INFO - psutil == 3.1.1 11:12:56 INFO - requests == 1.2.3 11:12:56 INFO - wsgiref == 0.1.2 11:12:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:56 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')]} 11:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:56 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')]} 11:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:56 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 0x7ff75059af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2972240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a010b0>, '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 0x2a01fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041', '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 11:12:56 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 11:12:56 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 11:12:56 INFO - Using env: {'DISPLAY': ':0', 11:12:56 INFO - 'HOME': '/home/cltbld', 11:12:56 INFO - 'LANG': 'en_US.UTF-8', 11:12:56 INFO - 'LANGUAGE': 'en_US:en', 11:12:56 INFO - 'LOGNAME': 'cltbld', 11:12:56 INFO - 'MAIL': '/var/mail/cltbld', 11:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:56 INFO - 'MOZ_NO_REMOTE': '1', 11:12:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:56 INFO - 'NO_EM_RESTART': '1', 11:12:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:56 INFO - 'PWD': '/builds/slave/test', 11:12:56 INFO - 'SHELL': '/bin/bash', 11:12:56 INFO - 'SHLVL': '1', 11:12:56 INFO - 'TERM': 'linux', 11:12:56 INFO - 'TMOUT': '86400', 11:12:56 INFO - 'USER': 'cltbld', 11:12:56 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041', 11:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:56 INFO - '_': '/tools/buildbot/bin/python'} 11:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:56 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)) 11:12:56 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)) 11:12:56 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)) 11:12:56 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)) 11:12:56 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)) 11:12:56 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)) 11:12:56 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)) 11:12:56 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)) 11:12:56 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)) 11:12:56 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)) 11:12:56 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)) 11:12:56 INFO - Cleaning up... 11:12:56 INFO - Return code: 0 11:12:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:12:56 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')]} 11:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:56 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')]} 11:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:56 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 0x7ff75059af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2972240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a010b0>, '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 0x2a01fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041', '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 11:12:56 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 11:12:56 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 11:12:56 INFO - Using env: {'DISPLAY': ':0', 11:12:56 INFO - 'HOME': '/home/cltbld', 11:12:56 INFO - 'LANG': 'en_US.UTF-8', 11:12:56 INFO - 'LANGUAGE': 'en_US:en', 11:12:56 INFO - 'LOGNAME': 'cltbld', 11:12:56 INFO - 'MAIL': '/var/mail/cltbld', 11:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:56 INFO - 'MOZ_NO_REMOTE': '1', 11:12:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:56 INFO - 'NO_EM_RESTART': '1', 11:12:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:56 INFO - 'PWD': '/builds/slave/test', 11:12:56 INFO - 'SHELL': '/bin/bash', 11:12:56 INFO - 'SHLVL': '1', 11:12:56 INFO - 'TERM': 'linux', 11:12:56 INFO - 'TMOUT': '86400', 11:12:56 INFO - 'USER': 'cltbld', 11:12:56 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041', 11:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:56 INFO - '_': '/tools/buildbot/bin/python'} 11:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:56 INFO - Downloading/unpacking jsonschema 11:12:56 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 11:12:56 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 11:12:56 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 11:12:56 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 11:12:56 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 11:12:56 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 11:12:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:12:58 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 11:12:58 INFO - Downloading/unpacking functools32 (from jsonschema) 11:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:58 INFO - Downloading functools32-3.2.3-2.tar.gz 11:12:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:12:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:12:58 INFO - warning: no files found matching '*.txt' 11:12:58 INFO - no previously-included directories found matching 'build' 11:12:58 INFO - no previously-included directories found matching 'dist' 11:12:58 INFO - no previously-included directories found matching '.git*' 11:12:58 INFO - Installing collected packages: jsonschema, functools32 11:12:58 INFO - Running setup.py install for functools32 11:12:58 INFO - warning: no files found matching '*.txt' 11:12:58 INFO - no previously-included directories found matching 'build' 11:12:58 INFO - no previously-included directories found matching 'dist' 11:12:58 INFO - no previously-included directories found matching '.git*' 11:12:58 INFO - Successfully installed jsonschema functools32 11:12:58 INFO - Cleaning up... 11:12:59 INFO - Return code: 0 11:12:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff75059af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2972240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a010b0>, '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 0x2a01fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041', '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 11:12:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:12:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:12:59 INFO - Using env: {'DISPLAY': ':0', 11:12:59 INFO - 'HOME': '/home/cltbld', 11:12:59 INFO - 'LANG': 'en_US.UTF-8', 11:12:59 INFO - 'LANGUAGE': 'en_US:en', 11:12:59 INFO - 'LOGNAME': 'cltbld', 11:12:59 INFO - 'MAIL': '/var/mail/cltbld', 11:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:59 INFO - 'MOZ_NO_REMOTE': '1', 11:12:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:59 INFO - 'NO_EM_RESTART': '1', 11:12:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:59 INFO - 'PWD': '/builds/slave/test', 11:12:59 INFO - 'SHELL': '/bin/bash', 11:12:59 INFO - 'SHLVL': '1', 11:12:59 INFO - 'TERM': 'linux', 11:12:59 INFO - 'TMOUT': '86400', 11:12:59 INFO - 'USER': 'cltbld', 11:12:59 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041', 11:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:59 INFO - '_': '/tools/buildbot/bin/python'} 11:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:59 INFO - Downloading/unpacking flake8 11:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:13:00 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 11:13:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:13:01 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 11:13:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:01 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 11:13:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:13:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:13:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:13:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:13:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:13:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:13:01 INFO - no previously-included directories found matching 'docs/_build' 11:13:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:13:01 INFO - Running setup.py install for pep8 11:13:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:13:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:13:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:13:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:13:01 INFO - no previously-included directories found matching 'docs/_build' 11:13:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:13:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:13:01 INFO - Cleaning up... 11:13:01 INFO - Return code: 0 11:13:01 INFO - Running post-action listener: _resource_record_post_action 11:13:01 INFO - Running post-action listener: _start_resource_monitoring 11:13:01 INFO - Starting resource monitoring. 11:13:01 INFO - ##### 11:13:01 INFO - ##### Running install step. 11:13:01 INFO - ##### 11:13:01 INFO - Running pre-action listener: _resource_record_pre_action 11:13:01 INFO - Running main action method: install 11:13:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:02 INFO - Reading from file tmpfile_stdout 11:13:02 INFO - Detecting whether we're running mozinstall >=1.0... 11:13:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:13:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:13:02 INFO - Reading from file tmpfile_stdout 11:13:02 INFO - Output received: 11:13:02 INFO - Usage: mozinstall [options] installer 11:13:02 INFO - Options: 11:13:02 INFO - -h, --help show this help message and exit 11:13:02 INFO - -d DEST, --destination=DEST 11:13:02 INFO - Directory to install application into. [default: 11:13:02 INFO - "/builds/slave/test"] 11:13:02 INFO - --app=APP Application being installed. [default: firefox] 11:13:02 INFO - mkdir: /builds/slave/test/build/application 11:13:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:13:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:13:16 INFO - Reading from file tmpfile_stdout 11:13:16 INFO - Output received: 11:13:16 INFO - /builds/slave/test/build/application/firefox/firefox 11:13:16 INFO - Running post-action listener: _resource_record_post_action 11:13:16 INFO - ##### 11:13:16 INFO - ##### Running run-tests step. 11:13:16 INFO - ##### 11:13:16 INFO - Running pre-action listener: _resource_record_pre_action 11:13:16 INFO - Running main action method: run_tests 11:13:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:13:16 INFO - Python 2.7.3 11:13:16 INFO - Return code: 0 11:13:16 INFO - grabbing minidump binary from tooltool 11:13: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')]} 11:13:16 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 0x2a010b0>, '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 0x2a01fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:13:16 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 11:13:16 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 11:13:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:13:16 INFO - Return code: 0 11:13:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:13:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:13:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:13:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:13:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:13:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:13:17 INFO - Return code: 0 11:13:17 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/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost'] in /builds/slave/test/build 11:13:17 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/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost 11:13:17 INFO - Using env: {'DISPLAY': ':0', 11:13:17 INFO - 'HOME': '/home/cltbld', 11:13:17 INFO - 'LANG': 'en_US.UTF-8', 11:13:17 INFO - 'LANGUAGE': 'en_US:en', 11:13:17 INFO - 'LOGNAME': 'cltbld', 11:13:17 INFO - 'MAIL': '/var/mail/cltbld', 11:13:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:13:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:17 INFO - 'MOZ_NO_REMOTE': '1', 11:13:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:17 INFO - 'NO_EM_RESTART': '1', 11:13:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:17 INFO - 'PWD': '/builds/slave/test', 11:13:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:13:17 INFO - 'SHELL': '/bin/bash', 11:13:17 INFO - 'SHLVL': '1', 11:13:17 INFO - 'TERM': 'linux', 11:13:17 INFO - 'TMOUT': '86400', 11:13:17 INFO - 'USER': 'cltbld', 11:13:17 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041', 11:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:17 INFO - '_': '/tools/buildbot/bin/python'} 11:13:17 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/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost'] with output_timeout 3600 11:13:17 INFO - mozversion INFO | application_buildid: 20151216101738 11:13:17 INFO - mozversion INFO | application_changeset: ebabcb64dab69728255088dffb73c15355ff1f21 11:13:17 INFO - mozversion INFO | application_display_name: Nightly 11:13:17 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:13:17 INFO - mozversion INFO | application_name: Firefox 11:13:17 INFO - mozversion INFO | application_remotingname: firefox 11:13:17 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:13:17 INFO - mozversion INFO | application_vendor: Mozilla 11:13:17 INFO - mozversion INFO | application_version: 46.0a1 11:13:17 INFO - mozversion INFO | platform_buildid: 20151216101738 11:13:17 INFO - mozversion INFO | platform_changeset: ebabcb64dab69728255088dffb73c15355ff1f21 11:13:17 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:13:17 INFO - mozversion INFO | platform_version: 46.0a1 11:13:17 INFO - 2015-12-16 11:13:17,862 DEBUG : using testdate: 1450293197 11:13:17 INFO - 2015-12-16 11:13:17,862 DEBUG : actual date: 1450293197 11:13:17 INFO - 2015-12-16 11:13:17,870 INFO : starting webserver on 'localhost:40572' 11:13:17 INFO - 2015-12-16 11:13:17,871 INFO : Starting test suite talos-linux64-ix-024.e 11:13:17 INFO - 2015-12-16 11:13:17,871 INFO : Starting test dromaeo_css 11:13:17 INFO - 2015-12-16 11:13:17,871 DEBUG : operating with platform_type : linux_ 11:13:17 INFO - 2015-12-16 11:13:17,872 INFO : Initialising browser for dromaeo_css test... 11:13:17 INFO - 2015-12-16 11:13:17,884 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYqUe17/profile http://localhost:40572/getInfo.html 11:13:22 INFO - 2015-12-16 11:13:22,496 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:13:22 INFO - 2015-12-16 11:13:22,496 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:13:22 INFO - 2015-12-16 11:13:22,496 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:13:22 INFO - 2015-12-16 11:13:22,496 DEBUG : BROWSER_OUTPUT: __metrics 11:13:22 INFO - 2015-12-16 11:13:22,633 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:13:23 INFO - 2015-12-16 11:13:23,521 INFO : Browser initialized. 11:13:23 INFO - 2015-12-16 11:13:23,522 INFO : Running cycle 1/1 for dromaeo_css test... 11:13:23 INFO - 2015-12-16 11:13:23,522 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYqUe17/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:13:35 INFO - 2015-12-16 11:13:35,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 143462400 11:13:35 INFO - 2015-12-16 11:13:35,578 DEBUG : BROWSER_OUTPUT: 11:14:25 INFO - 2015-12-16 11:14:25,234 DEBUG : BROWSER_OUTPUT: 1450293265230 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] 11:16:37 INFO - 2015-12-16 11:16:37,031 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40572/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40572/tests/dromaeo/cssquery-ext.html) 11:16:38 INFO - 2015-12-16 11:16:38,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 146857984 11:16:38 INFO - 2015-12-16 11:16:38,218 DEBUG : BROWSER_OUTPUT: 11:19:40 INFO - 2015-12-16 11:19:40,379 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40572/tests/dromaeo/cssquery-ext.html (next: http://localhost:40572/tests/dromaeo/cssquery-jquery.html) 11:19:40 INFO - 2015-12-16 11:19:40,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 145305600 11:19:40 INFO - 2015-12-16 11:19:40,973 DEBUG : BROWSER_OUTPUT: 11:22:42 INFO - 2015-12-16 11:22:42,788 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40572/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40572/tests/dromaeo/cssquery-mootools.html) 11:22:43 INFO - 2015-12-16 11:22:43,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 145014784 11:22:43 INFO - 2015-12-16 11:22:43,390 DEBUG : BROWSER_OUTPUT: 11:25:45 INFO - 2015-12-16 11:25:45,212 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40572/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40572/tests/dromaeo/cssquery-prototype.html) 11:25:45 INFO - 2015-12-16 11:25:45,806 DEBUG : BROWSER_OUTPUT: RSS: Main: 143880192 11:25:45 INFO - 2015-12-16 11:25:45,806 DEBUG : BROWSER_OUTPUT: 11:28:48 INFO - 2015-12-16 11:28:48,465 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40572/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40572/tests/dromaeo/cssquery-yui.html) 11:28:49 INFO - 2015-12-16 11:28:49,095 DEBUG : BROWSER_OUTPUT: RSS: Main: 144044032 11:28:49 INFO - 2015-12-16 11:28:49,095 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,464 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40572/tests/dromaeo/cssquery-yui.html (next: http://localhost:40572/tests/dromaeo/cssquery-dojo.html) 11:31:51 INFO - 2015-12-16 11:31:51,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 147075072 11:31:51 INFO - 2015-12-16 11:31:51,714 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,715 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:31:51 INFO - 2015-12-16 11:31:51,715 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:31:51 INFO - 2015-12-16 11:31:51,715 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:31:51 INFO - 2015-12-16 11:31:51,715 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:31:51 INFO - 2015-12-16 11:31:51,716 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2688.5698288273875;2732.357895894466;2782.8191167574105;2790.7627851632606;2791.6370871786676;4579.633629309656;4803.159447096761;4804.303376010481;4888.193448081062;4895.339129217555;4706.552877476643;4710.411198600175;4735.90528189436;4760.880977975552;4860.902781944359;4348.478182618091;4422.823087076513;4463.218936686083;4478.2386994211065;4525.818967241323;4377;4463.486699029604;4493.146302202571;4527.773611319437;4577.56513131252;4180.456540649696;4293.420388247578;4354.129174165179;4429.933550996738;4431.3131464622875;4383.627391671712;4437.0460351024685;4437.245668236407;4451.755153466558;4453.153900758878;4409.581089796464;4414.3378493225955;4417.469903611587;4422.181896349186;4425.269830478;4415.66882483815;4557.156925968707;4632.444106707217;4716.457607375127;4729.385179926622;5195.584353251768;5202.219667049935;5207.9479205207845;5223.660462069954;5224.190250511138;5214.5306922376785;5227.973860130713;5238.659487133325;5245.527902488756;5276.498732620434;4633.374494443241;4737.786799594027;4765.189917713997;4840.080384726926;4843.588294994965;5241.842744717665;5270.077736396115;5278.868028299324;5284.5772338212855;5286.81496147633;5121.897562048738;5137.306463627438;5141.9742901286;5142.100132476801;5143.639945203875;4931.9753401232765;5058.46886076964;5066.797328106908;5117.513836185556;5168.121419358718;5154.381474223117;5172.431032586413;5188.507091826271;5202.193659982633;5215.634905556651;4861.416630004422;5152.046871328741;5161.690298582097;5161.845144645667;5177.068127737043;4177.394277829698;4180.414741936132;4219.472565929259;4225.852095176654;4261.936070958876;3760.8683696070507;3767.340715374853;3770.6417890300377;3772.905677358088;3804.1630841214887;4265.189613973335;4375.431193944767;4468.061707041557;4492;4530.22986092365;5066.645334826527;5104.464031276737;5131.589472842238;5147.9227811582105;5182.792688292501;4421.867343979686;4466.173757854807;4473.3960915276675;4483.618892394118;4515.796789144496;4319.719218250803;4515.458145022552;4566.88582785433;4567.977160114245;4606.792694328763;4847.636427268039;4861.319415281863;4890.119778439915;4897.608191344755;4960.975195124001;5183.766730497212;5198.948010519997;5199.506046925536;5209.322788037683;5223.712695801767;4906.190478570996;4941;4949.480304567968;4957.157283261926;4974.477679843564;4841.12859685246;4963.205887058053;4969.850904472872;4989.575886049726;5101;5215.061288968022;5218.060749065205;5219.9217011744095;5224.869378265422;5233.581313494988;4995.62532810048;4998.475160108136;5004.349434573628;5010.849674509771;5068.2904393384215;4825.855224343275;4935.062338155739;4960.553550180501;5028.446870844277;5068.189089745623;4911.115999120049;4920.778564964657;4924.975375123101;4932.63005274613;4947.208446648519;4817.566419022305;5028.371453568304;5056.6713163644245;5058.241263810458;5095.464976177448;4753.263244197155;4781.569658730731;4800.423949126127;4802.423709154924;4823.5658790709 11:31:51 INFO - 2015-12-16 11:31:51,719 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.2830890614464;573.0945106731365;575.5913301555895;579.5971799599278;582.6911736779506;35269.82365088174;35924.28151436969;36012.639873601256;36062.27875442489;36075.27849443016;39099.21801563967;39452.80273598635;39522.8023859881;39598.20803583926;39677.60322396775;7844.058712954454;7954.801129971739;8021.438499305051;8023.839523209533;8027.397945154107;7818.569978651172;7873.842523149534;7896.960515197445;7925.128235894047;7927.4847134936335;7902.170272121431;7960.084590272135;7988.680452781882;7994.880076798852;8003.1996800320085;7814.296713295802;7850.175731548219;7921.20787921209;7973.720919767809;7990.760277191694;7826.686932522693;7964.084130325029;7970.322522585587;7979.880301795478;7981.68073277074;36388.09029774277;36590;36611;36830;36935;2406.145818234519;2690.213796043578;2845.5447128459555;2933.164048246261;3001.3847161331873;26130.477390452274;26202.73797262022;26310.473790524273;26509.602355964482;26551.203463896112;3381.1040074380307;3499.037764614726;3512.4906888501023;3564.7326450516316;3614.8373323200517;210504;213108.93445532827;213738.99999999846;213988;214022;51797.223041654404;52566.73716631392;55085;55518.44481555214;61858.69070654618;54268;54505.45494545004;54539.72730136324;54840;54842;12516.81224781629;12541.686457838627;12598.622041338775;12634.87365126337;12641.304728239851;10927;10978.615748448767;10979.28634638746;11022.50398732059;11034.613788517363;18905.338313158973;18989.715154272697;19070.33253836109;19109.713354299696;19160.71258931117;7536.623168841536;7701.383889288843;7791.376689864797;7843.37253019757;7845.960770196112;856.0540602634;856.6402111113347;874.6020560644891;892.5180402582532;967.4678926590348;28530.286742831595;29648;29725.702742972728;30453.086407407813;31212.375752484822;982.8230918434607;983.4443539400216;1047.502436342731;1076.2627600093804;1107.241539545414;13443.663908402368;13684.452621895012;13686.315684215948;13691.246981416118;13761.449542018407;564283;572922;573657;574023;576610.3508447292;47604.523954760705;48172.27741583879;48196;48229.51770482321;48286.51713482891;1236.208826351136;1264.8355713757153;1271.8918891894107;1273.9426725797362;1274.1781550899618;26697.19908402751;26931;27415.314617134733;27463.862680687267;27485.450290994468;39363.60636393714;39365.01587460222;39587.604123958394;39807.80096099501;39911.60088399195;243358;244443;244834;245108;245638;29185;38873.61126388813;39349;39400.802995984835;39726.60273397345;34705.438255278066;35940.64059359478;36118.8194059028;38857.61142388653;39137.41293880537;37256.44115338326;37990.81004594959;38686.22627547377;39367.80316098516;39555.80222098871;32695.346093078482;36613.81693091624;38715.41926871043;38828.80585597054;38965;33342;33344.66655333416;33437.83281083579;35407.468887966184;36005.27989440249;27888.302792430353;29895.55156672695;30544.694553054185;30636.693633063383;30678;24073.27780166598;24465.38836529101;24499.38751531226;24949.251522454357;25532.10637627674 11:31:51 INFO - 2015-12-16 11:31:51,719 DEBUG : BROWSER_OUTPUT: |2;jquery.html;343.5156429434498;346.5979463821967;346.83351991044304;347.43021444830475;347.59331582049;9694.369865958708;10311.43287119208;15072;15425.922870385646;16904.239309231085;15445.30496127674;15508.224588770572;15678.216089195523;16434.589135271624;16742.079185644783;5602;5605.579581531401;5651.2370829938045;5704.743286552094;5723.112917497774;5702.971485142569;5727.828165155052;5732.942670573282;5738.139279108146;5750.769969201227;5746.109353050284;6057.394260573951;6083.939160608382;6257.749690012394;6290.968545157268;6134.141220229149;6160.353162917896;6175.722092505848;6550.672466376662;6564.573302735307;6245.781397651061;6284.151639528651;6311.211098612674;6311.93688063118;6322.146510221107;18880;19394.806051939584;19933.9003304984;19963.600727985504;20138.496537586532;1973.0923775063488;1975.594424433507;2019.7576290845045;2059.2895451069357;2083.312506872728;13572.93213533926;13598.38807253676;13958.232297223649;13999.440022399092;14011.859881401157;1920.7407000054955;1941.2332128809182;1946.5717542140706;1955.8435325173953;1966.6263409952064;59033.40966590365;64838.351616483706;65158.67420662914;65497.3450265496;66373.66813165903;15191.696166076617;15497.612559685873;15520.456784012731;15536.300866461037;15545.844541554667;23199.188028418925;23233.7676623235;23254.883725581603;23556.411089722893;23593.410164745674;8090.919090809134;8201.753947381589;8212.753617391489;8215.26062654352;8248.54632995191;6735.865282694416;6785.491088168407;6786.728530858711;6789.1174147360525;6813.182418109858;7601.277878601634;7620.237976202336;7660.502067365604;7707.34487568563;7759.418043646749;1647.250501022032;1740.1560243282;3123.859426325821;3189.4418476766473;3221.5167724841463;781.6521647866645;828.0146625515617;863.1325517854516;876.9956150219208;961.9754960966549;15081.170535620646;15571.766423503657;15842.44551440694;16204.675906481805;16422.09678467672;794.5431376958272;878.5124256037833;880.1682410122501;926.1248120526038;947.6541062512272;8423.157684231528;8697;8710.303175745925;8794.560271986375;8891.19979201875;500008;504880;512917;513764.2935355973;518610;72859.63570182116;74510;74666.62666686632;75841;76157.61921190358;1033.9379637221791;1047.1256500821746;1049.884512703602;1057.8677665291839;1079.5088234852965;14886.776698349317;14900.925495372454;14925.626859328604;15195;15504.844951550791;33808.32383352368;34003;34382.65617343895;34817.651823482454;34935.825320873235;44298.3355249678;46572.53427465682;46715.766421167675;46822;47302.52697473119;8407.201315874981;8498.192671696179;8559.10129436425;8563.914360856561;8579;10455;12835.743285134058;15729.44946926852;16382.26279817435;16555.834441655912;11732.765344692887;13422.597322080353;13478.663033424244;13622.455101795817;14232.71905528466;13544.32278386057;13778.931105344409;14087.859121408655;14099.154050756988;14254.572362829133;14430.927845360706;14654.340554674853;14724.55826325212;14918.477853275082;15098.924505377403;8641.222289993932;8780.209781119729;8845.159709827556;8888.377813552988;8902;9741.707748767549;11073;13979.650508737363;14202.857971420153;14428.783568246694 11:31:51 INFO - 2015-12-16 11:31:51,723 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1479.9926000369996;1692.9238184281705;1708.9829101708979;1753.9473815785516;1778.8754787164903;7070.328318809711;7101.11236095488;7304.233055529173;7333.853322933538;7337.88993165103;7390.778276651709;7446.664900079496;7467.85064298715;7504.137024242214;7507.774766756992;2122.045079714131;2157.870527768331;2159.211887661;2160.1899287767087;2168.29530402619;2103.5056761661;2117.915283388663;2124.7875212478707;2129.669901165314;2135.1993002624017;1991.4324417541004;2026.0882602828785;2030.3908827351809;2037.7554693436734;2066.628006958747;2069.430906500709;2097.758757742864;2099.149844313048;2099.496120930973;2105.7473103227558;2075.9273425430188;2113.8520303578757;2119.6926445665445;2129.936101916945;2139.721836161289;7194.064771579661;7315.853682926365;7328.706851725925;7337.119545654556;7337.633118344115;4113.280175969194;4203.243416185085;4212.49450065994;4213.367994800774;4239.6396306314;2720.3949669694975;2793.706660800607;2820.562812764025;2858.571214317869;2863.3557449573887;850.8893843800329;886.9423487473293;896.5024411451642;899.1727610598265;915.3638221436105;9784.461854597994;9800.264980126447;9876.111149996463;9887.060729230712;9899.208063354914;3692.1508053147927;3760.191558814868;3793.0517370657335;3843.7117216208335;3848.7113466490127;7480.326770590673;7507;7584.431167662337;7616.543007419462;7625.6568454419685;4239.724417912826;4245.108527209259;4258.425112609758;4265.402843601898;4274.422952901318;3898.6101389861356;3926.6662333701956;3929.980350098231;3934.2918274710255;3945.072907866649;3043.1022848259818;3112.1752735525106;3130.0453361724894;3141.2932090279505;3163.4147682678777;924.8797656304637;931.9627214911463;933.808569243317;934.359963425056;936.3071327217809;834.8079941613463;872.8777971084053;976.8144052629978;1030.8144533983805;1129.108004676313;6625.701843417058;6675.46596272297;6707.49693772969;6707.832304192434;6713.865722685519;568.3151802078486;579.9478046975793;593.4688453833794;596.1326270276824;738.346563291491;5188.662736922163;5271.868203294948;5278.049951008778;5301.867453313621;5310.150375939831;8346.457480263764;8392.706255281159;8509.914900850912;8511.233988940901;8565.700200493078;8293.087760346358;8355.289800366916;8368.49789012649;8379.203975622306;8410.579471026424;6711.127553418024;6731.596104233761;6845.965770171118;6885.9999999999;6893.75871844493;6689.565178263398;6705;6749.122614060338;6755.3582409671;6773.05177275172;7470.6264686766535;7601.809954751176;7619.238076192337;7642.197569255148;7723.459357845121;7697;7858.882116768139;7898.644560994884;7969;7980.162082981204;6237.75048998035;6368.299487056513;6422.518311126591;6466.870662586816;6506.837329066811;6639.867202656016;6658;6660.134182556237;6662.866742665023;6669.83325416849;6181.196444462191;6264;6320.209973753281;6333.1766870306565;6425.389587989321;5856.472917437451;6297.559170857996;6340.207474065742;6401.167848179707;6444.8388790280615;6352.428281454691;6358.141650877073;6361.777337793155;6363.172787537591;6418.582792118497;5843.94156058434;5936.614120082181;5989.700514974321;6000.21997140369;6003.489703375088;5910.054391297544;6141.570090093651;6165.167702360124;6174.166487524127;6179.907301390573 11:31:51 INFO - 2015-12-16 11:31:51,723 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.6514345643868;306.3490083572408;309.80172689478735;312.651393696029;313.6330493322812;5635.436456354362;5684.772609095631;5711.571632127586;5748.913766293504;5825.155352473888;5625.831225063254;5654.180143879135;5687.8578035549135;5696.401877802833;5705.286839145107;4163.791810409482;4302.720323178999;4340.717853339539;4343.674224433164;4351.717138385995;4259.659227261812;4271.508776490697;4281.593248641374;4290.356446533014;4290.811686040126;4197.433346498215;4200.57994200579;4208.116295577933;4208.494980602332;4222.577742225768;4240.533541310453;4241.045764702917;4241.809118589671;4243.151369726067;4249.4475718156755;3629.1471504196493;3669.5596528416495;3669.9082522936874;3672.467492213614;3673.7244706647107;5286.101362768339;5402.8109016184635;5421.701806400646;5435.782568697247;5450.073487507094;4908.239222920453;4917.360743103373;4918.409790825088;4936.8765780855765;4937.901241975176;5922.2597175353085;5933.821985340447;5937.346891841894;5947.345791962881;5957.970210148965;3895.14306852492;4013.137175507251;4042.514898212233;4043.353063509824;4046.332355161395;6130.295016073164;6218.595791273553;6225.159603453521;6248.656323902183;6256.906146407762;4094.7952602369764;4095.7337773044655;4097.262492751273;4103.671706263492;4108.281050816096;4148.336266197394;4148.771817550003;4149.564295748964;4164.8542301019315;4170.416141740159;4627.305904114342;4635.814567417333;4804.25534042224;4810.326554282403;4831.73425461596;5842.678652674143;5865.706714664335;5873.148393483007;5875.11873219012;5906.675132867734;1411.1744629391715;1458.9860047267048;1460.5107289058071;1468;1471.3452513631332;983.3902980152351;1006.5168719014767;1012.2863381316155;1013.2501948558014;1014.1785154025263;5121.0014047261175;5127.410347809975;5136.383633963948;5155.484451554815;5160.690358578498;6113.449789518964;6115.602485838406;6116.174316467309;6128.724207410677;6145.262568491809;5128.820491282787;5129.666571672829;5135.255387968724;5138.897222055538;5142.408623008402;3209.791363561361;3274.9017529474154;3302.570665813429;3307.7849939753837;3311.9006429807146;5764.7117644117625;5790.305163380422;5855.2973643163095;5860.619059761102;5865.35481097079;6378.649174295459;6387.393197646216;6389.233292004989;6396.648184349812;6397.232332120176;5710.400407957105;5838.532917366516;5842.328132264759;5848.210491583667;5850.5612079094235;6164.753409863555;6170.81487555374;6171.228596425447;6172.506199503939;6186.845328866814;5978.8206353809455;5999.310079340931;6021.819345419644;6025.427584379477;6031.306399764083;5719.084946408555;5826.388229235869;5828.708564571839;5840.386759390203;5843.211166492469;4109.486314210723;4173.08192197716;4174.415581818608;4175.561566035522;4181.853635122756;5922.496587790086;6094.421030002142;6182.907256391068;6185.752569897334;6189.473894718999;5766.452187042224;5892.086726557391;5923.437273459014;5927.170196172453;5940.702964851654;5916.763329466773;5920.555958303058;5922.7927022554;5931.288245410578;5935.228420305332;5671.347795003628;5753.769849205984;5782.739776710142;5793.073108302651;5799;5918;5926.199963005111;5941.168236446987;5967.46292833647;5996.4902983245165;5794.275715535558;5820.708964551671;5822.0684690449325;5822.0684690449325;5824.592278540462 11:31:51 INFO - 2015-12-16 11:31:51,723 DEBUG : BROWSER_OUTPUT: |5;yui.html;699.8425354295284;709.8899670551064;753.2580408297829;764.4763337114077;771.8726410142331;11152.944235278823;11316.377599232039;11338.659840204786;11345.035671967882;11348.943255283722;11459.140564457679;11532.192746507748;11534.077273818095;11544.018758405524;11583.826242606368;620.0915658560208;629.0187307799847;780.3094261578516;788.0897563314367;813.808754942588;808.3250485844327;813.1177672225642;816.9060558035812;818.1164342510075;819.635262308273;851.8168593752373;858.2833334165979;859.8065435277044;860.5095095795399;862.4954401674996;840.9663613455485;844.1389782421926;849.3841964575695;849.570966661838;850.2432834777053;630.3444417805476;631.8957372033609;632.1213513216633;632.5192853431425;636.6466611030876;11588.710282242928;11650.883491165065;11688.883111168865;11698.824517632242;11708.180427370002;10967.341959482377;11233.26983746062;11359.829602555968;11416.372099534523;11686.415679216005;9216.907830921671;9310.255179585616;9404.576794044284;9416.293777966679;9417.1524562789;3148.622165340174;3225.629052658951;3251.219707270238;3251.4472539668313;3252.073159149631;37851.242975140616;38015.61984380176;38130.61869381298;38172.42741358854;38389.040273993094;9058.728238152735;9164.404313719588;9251.444913305224;9325.393849399767;9399.530023498797;16314;16370.508884733477;16399.83600164007;16475.505734827973;16497.422590209284;5988.640681559121;6125.601835880653;6205.193324867739;6330.746770129143;6360.395762402564;3467.063892748994;3559.875404360835;3567.8037707926314;3570.0539357070397;3576.213233088716;2539.250920978279;2560.5263026340185;2566.0762125634756;2571.7299683533333;2579.7678208961283;505.53490788474693;520.4587229281581;521.9112750832368;532.0317023018147;532.6724064700181;565.3724365953788;580.4456743809652;587.8618524646705;596.9015112506474;625.6277514878731;7782.883256751154;7895.486793358414;7916.366690664733;7956;7970.7652193854265;500.37453183520597;597.9356744993918;603.9389912533032;616.9722362493699;619.8791235709084;3548.4854696068924;3657.3782456982376;3806.467094606757;3813.866514671973;3830.214805964826;48127.278090828666;48585.75707121513;49555.25667114996;50151;51627;42260.78869605633;42606.786966064974;43153.784231078644;43220.56779432228;44193;38944.41583376252;39158.80420597936;39452.80273598671;40456.59543404587;40981.385279220834;7866.842663146819;8061.717839875576;8160.795980100307;8419.747407577783;8481.109483504144;29559.85220073972;30286.54570181405;30590.541141882444;31001.8449907749;31128.22179445532;37123.44314835226;38372.6162738369;38681.613183868925;38733.41899871448;38807.805960970014;10121.797564048826;10137.64518241858;10268;10347.379157250589;10397.11624511925;11025.283356581796;11144;11189.664310070712;11312.321260724382;11518.596849110576;10365.471008357286;10437.112845408225;10455.477226138815;10697.893021069689;10730.141588672732;10232.283740138118;10369.74075648115;10701.357918524913;11014.889851101387;11017.669469915916;9655.324127311022;10527.789444211227;10910.781784364426;11117.888821111685;11190.32858028521;9081.137291957253;9108.954455227682;9230.538473076454;9271.536423178948;9355.204807591432;9009.504477253813;9049.954750226207;9243.953780231055;9258.675946341846;9321.720348389288 11:31:51 INFO - 2015-12-16 11:31:51,723 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:31:51 INFO - 2015-12-16 11:31:51,723 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:31:51 INFO - 2015-12-16 11:31:51,724 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,316 11:31:51 INFO - 2015-12-16 11:31:51,724 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:31:51 INFO - 2015-12-16 11:31:51,724 DEBUG : BROWSER_OUTPUT: __startTimestamp1450294311711__endTimestamp 11:31:51 INFO - 2015-12-16 11:31:51,724 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,724 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:31:51 INFO - 2015-12-16 11:31:51,724 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:31:51 INFO - 2015-12-16 11:31:51,724 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,724 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4742.35 Median:4861.32 stddev:503.76 (10.4%) stddev-sans-first:478.85 11:31:51 INFO - 2015-12-16 11:31:51,726 DEBUG : BROWSER_OUTPUT: Values: 2688.6 2732.4 2782.8 2790.8 2791.6 4579.6 4803.2 4804.3 4888.2 4895.3 4706.6 4710.4 4735.9 4760.9 4860.9 4348.5 4422.8 4463.2 4478.2 4525.8 4377.0 4463.5 4493.1 4527.8 4577.6 4180.5 4293.4 4354.1 4429.9 4431.3 4383.6 4437.0 4437.2 4451.8 4453.2 4409.6 4414.3 4417.5 4422.2 4425.3 4415.7 4557.2 4632.4 4716.5 4729.4 5195.6 5202.2 5207.9 5223.7 5224.2 5214.5 5228.0 5238.7 5245.5 5276.5 4633.4 4737.8 4765.2 4840.1 4843.6 5241.8 5270.1 5278.9 5284.6 5286.8 5121.9 5137.3 5142.0 5142.1 5143.6 4932.0 5058.5 5066.8 5117.5 5168.1 5154.4 5172.4 5188.5 5202.2 5215.6 4861.4 5152.0 5161.7 5161.8 5177.1 4177.4 4180.4 4219.5 4225.9 4261.9 3760.9 3767.3 3770.6 3772.9 3804.2 4265.2 4375.4 4468.1 4492.0 4530.2 5066.6 5104.5 5131.6 5147.9 5182.8 4421.9 4466.2 4473.4 4483.6 4515.8 4319.7 4515.5 4566.9 4568.0 4606.8 4847.6 4861.3 4890.1 4897.6 4961.0 5183.8 5198.9 5199.5 5209.3 5223.7 4906.2 4941.0 4949.5 4957.2 4974.5 4841.1 4963.2 4969.9 4989.6 5101.0 5215.1 5218.1 5219.9 5224.9 5233.6 4995.6 4998.5 5004.3 5010.8 5068.3 4825.9 4935.1 4960.6 5028.4 5068.2 4911.1 4920.8 4925.0 4932.6 4947.2 4817.6 5028.4 5056.7 5058.2 5095.5 4753.3 4781.6 4800.4 4802.4 4823.6 11:31:51 INFO - 2015-12-16 11:31:51,726 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,726 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49329.94 Median:36612.41 stddev:101831.52 (278.1%) stddev-sans-first:102051.35 11:31:51 INFO - 2015-12-16 11:31:51,726 DEBUG : BROWSER_OUTPUT: Values: 562.3 573.1 575.6 579.6 582.7 35269.8 35924.3 36012.6 36062.3 36075.3 39099.2 39452.8 39522.8 39598.2 39677.6 7844.1 7954.8 8021.4 8023.8 8027.4 7818.6 7873.8 7897.0 7925.1 7927.5 7902.2 7960.1 7988.7 7994.9 8003.2 7814.3 7850.2 7921.2 7973.7 7990.8 7826.7 7964.1 7970.3 7979.9 7981.7 36388.1 36590.0 36611.0 36830.0 36935.0 2406.1 2690.2 2845.5 2933.2 3001.4 26130.5 26202.7 26310.5 26509.6 26551.2 3381.1 3499.0 3512.5 3564.7 3614.8 210504.0 213108.9 213739.0 213988.0 214022.0 51797.2 52566.7 55085.0 55518.4 61858.7 54268.0 54505.5 54539.7 54840.0 54842.0 12516.8 12541.7 12598.6 12634.9 12641.3 10927.0 10978.6 10979.3 11022.5 11034.6 18905.3 18989.7 19070.3 19109.7 19160.7 7536.6 7701.4 7791.4 7843.4 7846.0 856.1 856.6 874.6 892.5 967.5 28530.3 29648.0 29725.7 30453.1 31212.4 982.8 983.4 1047.5 1076.3 1107.2 13443.7 13684.5 13686.3 13691.2 13761.4 564283.0 572922.0 573657.0 574023.0 576610.4 47604.5 48172.3 48196.0 48229.5 48286.5 1236.2 1264.8 1271.9 1273.9 1274.2 26697.2 26931.0 27415.3 27463.9 27485.5 39363.6 39365.0 39587.6 39807.8 39911.6 243358.0 244443.0 244834.0 245108.0 245638.0 29185.0 38873.6 39349.0 39400.8 39726.6 34705.4 35940.6 36118.8 38857.6 39137.4 37256.4 37990.8 38686.2 39367.8 39555.8 32695.3 36613.8 38715.4 38828.8 38965.0 33342.0 33344.7 33437.8 35407.5 36005.3 27888.3 29895.6 30544.7 30636.7 30678.0 24073.3 24465.4 24499.4 24949.3 25532.1 11:31:51 INFO - 2015-12-16 11:31:51,726 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,726 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28332.90 Median:17582.62 stddev:83262.51 (473.5%) stddev-sans-first:83469.56 11:31:51 INFO - 2015-12-16 11:31:51,728 DEBUG : BROWSER_OUTPUT: Values: 343.5 346.6 346.8 347.4 347.6 9694.4 10311.4 15072.0 15425.9 16904.2 15445.3 15508.2 15678.2 16434.6 16742.1 5602.0 5605.6 5651.2 5704.7 5723.1 5703.0 5727.8 5732.9 5738.1 5750.8 5746.1 6057.4 6083.9 6257.7 6291.0 6134.1 6160.4 6175.7 6550.7 6564.6 6245.8 6284.2 6311.2 6311.9 6322.1 18880.0 19394.8 19933.9 19963.6 20138.5 1973.1 1975.6 2019.8 2059.3 2083.3 13572.9 13598.4 13958.2 13999.4 14011.9 1920.7 1941.2 1946.6 1955.8 1966.6 59033.4 64838.4 65158.7 65497.3 66373.7 15191.7 15497.6 15520.5 15536.3 15545.8 23199.2 23233.8 23254.9 23556.4 23593.4 8090.9 8201.8 8212.8 8215.3 8248.5 6735.9 6785.5 6786.7 6789.1 6813.2 7601.3 7620.2 7660.5 7707.3 7759.4 1647.3 1740.2 3123.9 3189.4 3221.5 781.7 828.0 863.1 877.0 962.0 15081.2 15571.8 15842.4 16204.7 16422.1 794.5 878.5 880.2 926.1 947.7 8423.2 8697.0 8710.3 8794.6 8891.2 500008.0 504880.0 512917.0 513764.3 518610.0 72859.6 74510.0 74666.6 75841.0 76157.6 1033.9 1047.1 1049.9 1057.9 1079.5 14886.8 14900.9 14925.6 15195.0 15504.8 33808.3 34003.0 34382.7 34817.7 34935.8 44298.3 46572.5 46715.8 46822.0 47302.5 8407.2 8498.2 8559.1 8563.9 8579.0 10455.0 12835.7 15729.4 16382.3 16555.8 11732.8 13422.6 13478.7 13622.5 14232.7 13544.3 13778.9 14087.9 14099.2 14254.6 14430.9 14654.3 14724.6 14918.5 15098.9 8641.2 8780.2 8845.2 8888.4 8902.0 9741.7 11073.0 13979.7 14202.9 14428.8 11:31:51 INFO - 2015-12-16 11:31:51,728 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,728 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4972.34 Median:6359.96 stddev:2590.80 (40.7%) stddev-sans-first:2584.77 11:31:51 INFO - 2015-12-16 11:31:51,728 DEBUG : BROWSER_OUTPUT: Values: 1480.0 1692.9 1709.0 1753.9 1778.9 7070.3 7101.1 7304.2 7333.9 7337.9 7390.8 7446.7 7467.9 7504.1 7507.8 2122.0 2157.9 2159.2 2160.2 2168.3 2103.5 2117.9 2124.8 2129.7 2135.2 1991.4 2026.1 2030.4 2037.8 2066.6 2069.4 2097.8 2099.1 2099.5 2105.7 2075.9 2113.9 2119.7 2129.9 2139.7 7194.1 7315.9 7328.7 7337.1 7337.6 4113.3 4203.2 4212.5 4213.4 4239.6 2720.4 2793.7 2820.6 2858.6 2863.4 850.9 886.9 896.5 899.2 915.4 9784.5 9800.3 9876.1 9887.1 9899.2 3692.2 3760.2 3793.1 3843.7 3848.7 7480.3 7507.0 7584.4 7616.5 7625.7 4239.7 4245.1 4258.4 4265.4 4274.4 3898.6 3926.7 3930.0 3934.3 3945.1 3043.1 3112.2 3130.0 3141.3 3163.4 924.9 932.0 933.8 934.4 936.3 834.8 872.9 976.8 1030.8 1129.1 6625.7 6675.5 6707.5 6707.8 6713.9 568.3 579.9 593.5 596.1 738.3 5188.7 5271.9 5278.0 5301.9 5310.2 8346.5 8392.7 8509.9 8511.2 8565.7 8293.1 8355.3 8368.5 8379.2 8410.6 6711.1 6731.6 6846.0 6886.0 6893.8 6689.6 6705.0 6749.1 6755.4 6773.1 7470.6 7601.8 7619.2 7642.2 7723.5 7697.0 7858.9 7898.6 7969.0 7980.2 6237.8 6368.3 6422.5 6466.9 6506.8 6639.9 6658.0 6660.1 6662.9 6669.8 6181.2 6264.0 6320.2 6333.2 6425.4 5856.5 6297.6 6340.2 6401.2 6444.8 6352.4 6358.1 6361.8 6363.2 6418.6 5843.9 5936.6 5989.7 6000.2 6003.5 5910.1 6141.6 6165.2 6174.2 6179.9 11:31:51 INFO - 2015-12-16 11:31:51,728 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,728 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4876.25 Median:5644.81 stddev:1468.65 (26.0%) stddev-sans-first:1431.98 11:31:51 INFO - 2015-12-16 11:31:51,729 DEBUG : BROWSER_OUTPUT: Values: 296.7 306.3 309.8 312.7 313.6 5635.4 5684.8 5711.6 5748.9 5825.2 5625.8 5654.2 5687.9 5696.4 5705.3 4163.8 4302.7 4340.7 4343.7 4351.7 4259.7 4271.5 4281.6 4290.4 4290.8 4197.4 4200.6 4208.1 4208.5 4222.6 4240.5 4241.0 4241.8 4243.2 4249.4 3629.1 3669.6 3669.9 3672.5 3673.7 5286.1 5402.8 5421.7 5435.8 5450.1 4908.2 4917.4 4918.4 4936.9 4937.9 5922.3 5933.8 5937.3 5947.3 5958.0 3895.1 4013.1 4042.5 4043.4 4046.3 6130.3 6218.6 6225.2 6248.7 6256.9 4094.8 4095.7 4097.3 4103.7 4108.3 4148.3 4148.8 4149.6 4164.9 4170.4 4627.3 4635.8 4804.3 4810.3 4831.7 5842.7 5865.7 5873.1 5875.1 5906.7 1411.2 1459.0 1460.5 1468.0 1471.3 983.4 1006.5 1012.3 1013.3 1014.2 5121.0 5127.4 5136.4 5155.5 5160.7 6113.4 6115.6 6116.2 6128.7 6145.3 5128.8 5129.7 5135.3 5138.9 5142.4 3209.8 3274.9 3302.6 3307.8 3311.9 5764.7 5790.3 5855.3 5860.6 5865.4 6378.6 6387.4 6389.2 6396.6 6397.2 5710.4 5838.5 5842.3 5848.2 5850.6 6164.8 6170.8 6171.2 6172.5 6186.8 5978.8 5999.3 6021.8 6025.4 6031.3 5719.1 5826.4 5828.7 5840.4 5843.2 4109.5 4173.1 4174.4 4175.6 4181.9 5922.5 6094.4 6182.9 6185.8 6189.5 5766.5 5892.1 5923.4 5927.2 5940.7 5916.8 5920.6 5922.8 5931.3 5935.2 5671.3 5753.8 5782.7 5793.1 5799.0 5918.0 5926.2 5941.2 5967.5 5996.5 5794.3 5820.7 5822.1 5822.1 5824.6 11:31:51 INFO - 2015-12-16 11:31:51,730 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,730 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12048.80 Median:42880.29 stddev:13428.96 (31.3%) stddev-sans-first:13439.58 11:31:51 INFO - 2015-12-16 11:31:51,731 DEBUG : BROWSER_OUTPUT: Values: 699.8 709.9 753.3 764.5 771.9 11152.9 11316.4 11338.7 11345.0 11348.9 11459.1 11532.2 11534.1 11544.0 11583.8 620.1 629.0 780.3 788.1 813.8 808.3 813.1 816.9 818.1 819.6 851.8 858.3 859.8 860.5 862.5 841.0 844.1 849.4 849.6 850.2 630.3 631.9 632.1 632.5 636.6 11588.7 11650.9 11688.9 11698.8 11708.2 10967.3 11233.3 11359.8 11416.4 11686.4 9216.9 9310.3 9404.6 9416.3 9417.2 3148.6 3225.6 3251.2 3251.4 3252.1 37851.2 38015.6 38130.6 38172.4 38389.0 9058.7 9164.4 9251.4 9325.4 9399.5 16314.0 16370.5 16399.8 16475.5 16497.4 5988.6 6125.6 6205.2 6330.7 6360.4 3467.1 3559.9 3567.8 3570.1 3576.2 2539.3 2560.5 2566.1 2571.7 2579.8 505.5 520.5 521.9 532.0 532.7 565.4 580.4 587.9 596.9 625.6 7782.9 7895.5 7916.4 7956.0 7970.8 500.4 597.9 603.9 617.0 619.9 3548.5 3657.4 3806.5 3813.9 3830.2 48127.3 48585.8 49555.3 50151.0 51627.0 42260.8 42606.8 43153.8 43220.6 44193.0 38944.4 39158.8 39452.8 40456.6 40981.4 7866.8 8061.7 8160.8 8419.7 8481.1 29559.9 30286.5 30590.5 31001.8 31128.2 37123.4 38372.6 38681.6 38733.4 38807.8 10121.8 10137.6 10268.0 10347.4 10397.1 11025.3 11144.0 11189.7 11312.3 11518.6 10365.5 10437.1 10455.5 10697.9 10730.1 10232.3 10369.7 10701.4 11014.9 11017.7 9655.3 10527.8 10910.8 11117.9 11190.3 9081.1 9109.0 9230.5 9271.5 9355.2 9009.5 9050.0 9244.0 9258.7 9321.7 11:31:51 INFO - 2015-12-16 11:31:51,731 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:31:51 INFO - 2015-12-16 11:31:51,731 DEBUG : BROWSER_OUTPUT: 11:31:52 INFO - 2015-12-16 11:31:52,465 INFO : Browser exited with error code: 0 11:31:52 INFO - 2015-12-16 11:31:52,484 INFO : Completed test dromaeo_css (00:18:34) 11:31:52 INFO - 2015-12-16 11:31:52,484 INFO : Starting test kraken 11:31:52 INFO - 2015-12-16 11:31:52,484 DEBUG : operating with platform_type : linux_ 11:31:52 INFO - 2015-12-16 11:31:52,484 INFO : Initialising browser for kraken test... 11:31:52 INFO - 2015-12-16 11:31:52,490 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmKD9lb/profile http://localhost:40572/getInfo.html 11:31:56 INFO - 2015-12-16 11:31:56,875 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:31:56 INFO - 2015-12-16 11:31:56,875 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:31:56 INFO - 2015-12-16 11:31:56,875 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:31:56 INFO - 2015-12-16 11:31:56,875 DEBUG : BROWSER_OUTPUT: __metrics 11:31:57 INFO - 2015-12-16 11:31:57,012 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:31:57 INFO - 2015-12-16 11:31:57,909 INFO : Browser initialized. 11:31:57 INFO - 2015-12-16 11:31:57,909 INFO : Running cycle 1/1 for kraken test... 11:31:57 INFO - 2015-12-16 11:31:57,910 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmKD9lb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:32:09 INFO - 2015-12-16 11:32:09,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 143282176 11:32:09 INFO - 2015-12-16 11:32:09,968 DEBUG : BROWSER_OUTPUT: 11:32:12 INFO - 2015-12-16 11:32:12,543 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40572/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40572/tests/kraken/driver.html?testName=audio-beat-detection) 11:32:13 INFO - 2015-12-16 11:32:13,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 143052800 11:32:13 INFO - 2015-12-16 11:32:13,165 DEBUG : BROWSER_OUTPUT: 11:32:15 INFO - 2015-12-16 11:32:15,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40572/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40572/tests/kraken/driver.html?testName=audio-dft) 11:32:16 INFO - 2015-12-16 11:32:16,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 143593472 11:32:16 INFO - 2015-12-16 11:32:16,499 DEBUG : BROWSER_OUTPUT: 11:32:19 INFO - 2015-12-16 11:32:19,423 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40572/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40572/tests/kraken/driver.html?testName=audio-fft) 11:32:20 INFO - 2015-12-16 11:32:20,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 138285056 11:32:20 INFO - 2015-12-16 11:32:20,012 DEBUG : BROWSER_OUTPUT: 11:32:22 INFO - 2015-12-16 11:32:22,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40572/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40572/tests/kraken/driver.html?testName=audio-oscillator) 11:32:22 INFO - 2015-12-16 11:32:22,707 DEBUG : BROWSER_OUTPUT: RSS: Main: 138326016 11:32:22 INFO - 2015-12-16 11:32:22,708 DEBUG : BROWSER_OUTPUT: 11:32:24 INFO - 2015-12-16 11:32:24,962 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40572/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40572/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:32:25 INFO - 2015-12-16 11:32:25,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 138772480 11:32:25 INFO - 2015-12-16 11:32:25,536 DEBUG : BROWSER_OUTPUT: 11:32:28 INFO - 2015-12-16 11:32:28,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40572/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40572/tests/kraken/driver.html?testName=imaging-darkroom) 11:32:29 INFO - 2015-12-16 11:32:29,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 139948032 11:32:29 INFO - 2015-12-16 11:32:29,187 DEBUG : BROWSER_OUTPUT: 11:32:32 INFO - 2015-12-16 11:32:32,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40572/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40572/tests/kraken/driver.html?testName=imaging-desaturate) 11:32:33 INFO - 2015-12-16 11:32:33,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 137482240 11:32:33 INFO - 2015-12-16 11:32:33,250 DEBUG : BROWSER_OUTPUT: 11:32:36 INFO - 2015-12-16 11:32:36,133 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40572/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40572/tests/kraken/driver.html?testName=json-parse-financial) 11:32:36 INFO - 2015-12-16 11:32:36,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 139288576 11:32:36 INFO - 2015-12-16 11:32:36,739 DEBUG : BROWSER_OUTPUT: 11:32:38 INFO - 2015-12-16 11:32:38,521 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40572/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40572/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:32:39 INFO - 2015-12-16 11:32:39,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 140632064 11:32:39 INFO - 2015-12-16 11:32:39,115 DEBUG : BROWSER_OUTPUT: 11:32:41 INFO - 2015-12-16 11:32:41,010 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40572/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40572/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:32:41 INFO - 2015-12-16 11:32:41,617 DEBUG : BROWSER_OUTPUT: RSS: Main: 139853824 11:32:41 INFO - 2015-12-16 11:32:41,617 DEBUG : BROWSER_OUTPUT: 11:32:43 INFO - 2015-12-16 11:32:43,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40572/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40572/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:32:44 INFO - 2015-12-16 11:32:44,416 DEBUG : BROWSER_OUTPUT: RSS: Main: 139898880 11:32:44 INFO - 2015-12-16 11:32:44,417 DEBUG : BROWSER_OUTPUT: 11:32:47 INFO - 2015-12-16 11:32:47,015 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40572/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40572/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:32:47 INFO - 2015-12-16 11:32:47,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 140517376 11:32:47 INFO - 2015-12-16 11:32:47,621 DEBUG : BROWSER_OUTPUT: 11:32:50 INFO - 2015-12-16 11:32:50,257 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40572/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40572/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:32:50 INFO - 2015-12-16 11:32:50,858 DEBUG : BROWSER_OUTPUT: RSS: Main: 141197312 11:32:50 INFO - 2015-12-16 11:32:50,858 DEBUG : BROWSER_OUTPUT: 11:32:52 INFO - 2015-12-16 11:32:52,655 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40572/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40572/tests/kraken/driver.html?testName=ai-astar) 11:32:52 INFO - 2015-12-16 11:32:52,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 140144640 11:32:52 INFO - 2015-12-16 11:32:52,906 DEBUG : BROWSER_OUTPUT: 11:32:52 INFO - 2015-12-16 11:32:52,909 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:32:52 INFO - 2015-12-16 11:32:52,909 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:32:52 INFO - 2015-12-16 11:32:52,909 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:32:52 INFO - 2015-12-16 11:32:52,909 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:32:52 INFO - 2015-12-16 11:32:52,909 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;111;116;117;115;128;115;114;115;115 11:32:52 INFO - 2015-12-16 11:32:52,909 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;130;160;169;133;163;154;142;166;139 11:32:52 INFO - 2015-12-16 11:32:52,909 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;166;162;162;165;166;161;164;163 11:32:52 INFO - 2015-12-16 11:32:52,909 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;73;81;133;72;71;72;74;87 11:32:52 INFO - 2015-12-16 11:32:52,910 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;128;94;94;95;129;94;96;141 11:32:52 INFO - 2015-12-16 11:32:52,910 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;113;113;109;110;112;110;109;110 11:32:52 INFO - 2015-12-16 11:32:52,910 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;151;147;149;146;148;148;149;148;149;147 11:32:52 INFO - 2015-12-16 11:32:52,910 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;96;96;96;95;97;97;96 11:32:52 INFO - 2015-12-16 11:32:52,910 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;74;74;75;77;74;75;75;75;73 11:32:52 INFO - 2015-12-16 11:32:52,910 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;68;68;69;68;68;68;67 11:32:52 INFO - 2015-12-16 11:32:52,910 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;86;94;85;85;84;86;86;97;99 11:32:52 INFO - 2015-12-16 11:32:52,910 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;134;130;129;130;125;125;140;125;124;137 11:32:52 INFO - 2015-12-16 11:32:52,910 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;156;152;154;146;142;144;153;140;141 11:32:52 INFO - 2015-12-16 11:32:52,910 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;72;73;72;73;70;70;72;73;70 11:32:52 INFO - 2015-12-16 11:32:52,910 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:32:52 INFO - 2015-12-16 11:32:52,911 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:32:52 INFO - 2015-12-16 11:32:52,911 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,789 11:32:52 INFO - 2015-12-16 11:32:52,911 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:32:52 INFO - 2015-12-16 11:32:52,911 DEBUG : BROWSER_OUTPUT: __startTimestamp1450294372908__endTimestamp 11:32:52 INFO - 2015-12-16 11:32:52,911 DEBUG : BROWSER_OUTPUT: 11:32:52 INFO - 2015-12-16 11:32:52,914 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:32:52 INFO - 2015-12-16 11:32:52,914 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:32:52 INFO - 2015-12-16 11:32:52,914 DEBUG : BROWSER_OUTPUT: 11:32:52 INFO - 2015-12-16 11:32:52,914 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:116.00 Median:115.00 stddev:4.50 (3.9%) stddev-sans-first:4.71 11:32:52 INFO - 2015-12-16 11:32:52,915 DEBUG : BROWSER_OUTPUT: Values: 114.0 111.0 116.0 117.0 115.0 128.0 115.0 114.0 115.0 115.0 11:32:52 INFO - 2015-12-16 11:32:52,915 DEBUG : BROWSER_OUTPUT: 11:32:52 INFO - 2015-12-16 11:32:52,915 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.10 Median:157.50 stddev:14.10 (9.0%) stddev-sans-first:14.88 11:32:52 INFO - 2015-12-16 11:32:52,915 DEBUG : BROWSER_OUTPUT: Values: 155.0 130.0 160.0 169.0 133.0 163.0 154.0 142.0 166.0 139.0 11:32:52 INFO - 2015-12-16 11:32:52,915 DEBUG : BROWSER_OUTPUT: 11:32:52 INFO - 2015-12-16 11:32:52,915 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:1.78 (1.1%) stddev-sans-first:1.88 11:32:52 INFO - 2015-12-16 11:32:52,915 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 166.0 162.0 162.0 165.0 166.0 161.0 164.0 163.0 11:32:52 INFO - 2015-12-16 11:32:52,915 DEBUG : BROWSER_OUTPUT: 11:32:52 INFO - 2015-12-16 11:32:52,915 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.90 Median:73.00 stddev:18.98 (26.0%) stddev-sans-first:19.92 11:32:52 INFO - 2015-12-16 11:32:52,915 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 73.0 81.0 133.0 72.0 71.0 72.0 74.0 87.0 11:32:52 INFO - 2015-12-16 11:32:52,916 DEBUG : BROWSER_OUTPUT: 11:32:52 INFO - 2015-12-16 11:32:52,916 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.10 Median:94.50 stddev:18.66 (19.7%) stddev-sans-first:19.35 11:32:52 INFO - 2015-12-16 11:32:52,916 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 128.0 94.0 94.0 95.0 129.0 94.0 96.0 141.0 11:32:52 INFO - 2015-12-16 11:32:52,916 DEBUG : BROWSER_OUTPUT: 11:32:52 INFO - 2015-12-16 11:32:52,916 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.60 Median:110.00 stddev:1.51 (1.4%) stddev-sans-first:1.58 11:32:52 INFO - 2015-12-16 11:32:52,917 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 113.0 113.0 109.0 110.0 112.0 110.0 109.0 110.0 11:32:52 INFO - 2015-12-16 11:32:52,917 DEBUG : BROWSER_OUTPUT: 11:32:52 INFO - 2015-12-16 11:32:52,917 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:1.40 (0.9%) stddev-sans-first:1.05 11:32:52 INFO - 2015-12-16 11:32:52,917 DEBUG : BROWSER_OUTPUT: Values: 151.0 147.0 149.0 146.0 148.0 148.0 149.0 148.0 149.0 147.0 11:32:52 INFO - 2015-12-16 11:32:52,918 DEBUG : BROWSER_OUTPUT: 11:32:52 INFO - 2015-12-16 11:32:52,918 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 11:32:52 INFO - 2015-12-16 11:32:52,918 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 96.0 96.0 96.0 95.0 97.0 97.0 96.0 11:32:52 INFO - 2015-12-16 11:32:52,918 DEBUG : BROWSER_OUTPUT: 11:32:52 INFO - 2015-12-16 11:32:52,918 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.60 Median:75.00 stddev:1.07 (1.4%) stddev-sans-first:1.12 11:32:52 INFO - 2015-12-16 11:32:52,918 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 74.0 75.0 77.0 74.0 75.0 75.0 75.0 73.0 11:32:52 INFO - 2015-12-16 11:32:52,918 DEBUG : BROWSER_OUTPUT: 11:32:52 INFO - 2015-12-16 11:32:52,918 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 11:32:52 INFO - 2015-12-16 11:32:52,918 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 67.0 11:32:52 INFO - 2015-12-16 11:32:52,918 DEBUG : BROWSER_OUTPUT: 11:32:52 INFO - 2015-12-16 11:32:52,919 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:86.50 stddev:5.55 (6.4%) stddev-sans-first:5.84 11:32:52 INFO - 2015-12-16 11:32:52,919 DEBUG : BROWSER_OUTPUT: Values: 87.0 86.0 94.0 85.0 85.0 84.0 86.0 86.0 97.0 99.0 11:32:52 INFO - 2015-12-16 11:32:52,919 DEBUG : BROWSER_OUTPUT: 11:32:52 INFO - 2015-12-16 11:32:52,919 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:130.00 stddev:5.55 (4.3%) stddev-sans-first:5.68 11:32:52 INFO - 2015-12-16 11:32:52,919 DEBUG : BROWSER_OUTPUT: Values: 134.0 130.0 129.0 130.0 125.0 125.0 140.0 125.0 124.0 137.0 11:32:52 INFO - 2015-12-16 11:32:52,919 DEBUG : BROWSER_OUTPUT: 11:32:52 INFO - 2015-12-16 11:32:52,919 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.00 Median:149.00 stddev:6.11 (4.1%) stddev-sans-first:6.21 11:32:52 INFO - 2015-12-16 11:32:52,919 DEBUG : BROWSER_OUTPUT: Values: 142.0 156.0 152.0 154.0 146.0 142.0 144.0 153.0 140.0 141.0 11:32:52 INFO - 2015-12-16 11:32:52,919 DEBUG : BROWSER_OUTPUT: 11:32:52 INFO - 2015-12-16 11:32:52,919 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:72.00 stddev:1.25 (1.7%) stddev-sans-first:1.32 11:32:52 INFO - 2015-12-16 11:32:52,919 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 72.0 73.0 70.0 70.0 72.0 73.0 70.0 11:32:52 INFO - 2015-12-16 11:32:52,919 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:32:52 INFO - 2015-12-16 11:32:52,919 DEBUG : BROWSER_OUTPUT: 11:32:53 INFO - 2015-12-16 11:32:53,841 INFO : Browser exited with error code: 0 11:32:53 INFO - 2015-12-16 11:32:53,895 INFO : Completed test kraken (00:01:01) 11:32:53 INFO - 2015-12-16 11:32:53,895 INFO : Starting test v8_7 11:32:53 INFO - 2015-12-16 11:32:53,895 DEBUG : operating with platform_type : linux_ 11:32:53 INFO - 2015-12-16 11:32:53,895 INFO : Initialising browser for v8_7 test... 11:32:53 INFO - 2015-12-16 11:32:53,901 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY2L9EL/profile http://localhost:40572/getInfo.html 11:32:58 INFO - 2015-12-16 11:32:58,425 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:32:58 INFO - 2015-12-16 11:32:58,425 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:32:58 INFO - 2015-12-16 11:32:58,425 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:32:58 INFO - 2015-12-16 11:32:58,425 DEBUG : BROWSER_OUTPUT: __metrics 11:32:58 INFO - 2015-12-16 11:32:58,553 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:32:59 INFO - 2015-12-16 11:32:59,505 INFO : Browser initialized. 11:32:59 INFO - 2015-12-16 11:32:59,505 INFO : Running cycle 1/1 for v8_7 test... 11:32:59 INFO - 2015-12-16 11:32:59,506 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY2L9EL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:33:11 INFO - 2015-12-16 11:33:11,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 143241216 11:33:11 INFO - 2015-12-16 11:33:11,496 DEBUG : BROWSER_OUTPUT: 11:33:32 INFO - 2015-12-16 11:33:32,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40572/tests/v8_7/run.html (next: http://localhost:40572/tests/v8_7/run.html) 11:33:33 INFO - 2015-12-16 11:33:33,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 138448896 11:33:33 INFO - 2015-12-16 11:33:33,220 DEBUG : BROWSER_OUTPUT: 11:33:33 INFO - 2015-12-16 11:33:33,221 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:33:33 INFO - 2015-12-16 11:33:33,221 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:33:33 INFO - 2015-12-16 11:33:33,221 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:33:33 INFO - 2015-12-16 11:33:33,221 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:33:33 INFO - 2015-12-16 11:33:33,222 DEBUG : BROWSER_OUTPUT: |0;Richards;165.92002654720426 11:33:33 INFO - 2015-12-16 11:33:33,222 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.97731076808628 11:33:33 INFO - 2015-12-16 11:33:33,222 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.700638711469 11:33:33 INFO - 2015-12-16 11:33:33,222 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 11:33:33 INFO - 2015-12-16 11:33:33,223 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1086.9565217391305 11:33:33 INFO - 2015-12-16 11:33:33,223 DEBUG : BROWSER_OUTPUT: |5;Earley;720.1438848920864 11:33:33 INFO - 2015-12-16 11:33:33,223 DEBUG : BROWSER_OUTPUT: |6;Boyer;12345.67901234568 11:33:33 INFO - 2015-12-16 11:33:33,223 DEBUG : BROWSER_OUTPUT: |7;RegExp;26526.315789473683 11:33:33 INFO - 2015-12-16 11:33:33,224 DEBUG : BROWSER_OUTPUT: |8;Splay;596.9176052163604 11:33:33 INFO - 2015-12-16 11:33:33,224 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 11:33:33 INFO - 2015-12-16 11:33:33,224 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:33:33 INFO - 2015-12-16 11:33:33,224 DEBUG : BROWSER_OUTPUT: __startTimestamp1450294413217__endTimestamp 11:33:33 INFO - 2015-12-16 11:33:33,225 DEBUG : BROWSER_OUTPUT: 11:33:33 INFO - 2015-12-16 11:33:33,225 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:33:33 INFO - 2015-12-16 11:33:33,225 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:33:33 INFO - 2015-12-16 11:33:33,226 DEBUG : BROWSER_OUTPUT: 11:33:33 INFO - 2015-12-16 11:33:33,226 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.92 Median:165.92 stddev:0.00 (0.0%) 11:33:33 INFO - 2015-12-16 11:33:33,226 DEBUG : BROWSER_OUTPUT: Values: 165.9 11:33:33 INFO - 2015-12-16 11:33:33,226 DEBUG : BROWSER_OUTPUT: 11:33:33 INFO - 2015-12-16 11:33:33,227 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.98 Median:185.98 stddev:0.00 (0.0%) 11:33:33 INFO - 2015-12-16 11:33:33,227 DEBUG : BROWSER_OUTPUT: Values: 186.0 11:33:33 INFO - 2015-12-16 11:33:33,227 DEBUG : BROWSER_OUTPUT: 11:33:33 INFO - 2015-12-16 11:33:33,227 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.70 Median:277.70 stddev:0.00 (0.0%) 11:33:33 INFO - 2015-12-16 11:33:33,227 DEBUG : BROWSER_OUTPUT: Values: 277.7 11:33:33 INFO - 2015-12-16 11:33:33,228 DEBUG : BROWSER_OUTPUT: 11:33:33 INFO - 2015-12-16 11:33:33,228 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 11:33:33 INFO - 2015-12-16 11:33:33,228 DEBUG : BROWSER_OUTPUT: Values: 5186.5 11:33:33 INFO - 2015-12-16 11:33:33,228 DEBUG : BROWSER_OUTPUT: 11:33:33 INFO - 2015-12-16 11:33:33,229 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1086.96 Median:1086.96 stddev:0.00 (0.0%) 11:33:33 INFO - 2015-12-16 11:33:33,229 DEBUG : BROWSER_OUTPUT: Values: 1087.0 11:33:33 INFO - 2015-12-16 11:33:33,229 DEBUG : BROWSER_OUTPUT: 11:33:33 INFO - 2015-12-16 11:33:33,229 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:720.14 Median:720.14 stddev:0.00 (0.0%) 11:33:33 INFO - 2015-12-16 11:33:33,229 DEBUG : BROWSER_OUTPUT: Values: 720.1 11:33:33 INFO - 2015-12-16 11:33:33,229 DEBUG : BROWSER_OUTPUT: 11:33:33 INFO - 2015-12-16 11:33:33,229 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 11:33:33 INFO - 2015-12-16 11:33:33,229 DEBUG : BROWSER_OUTPUT: Values: 12345.7 11:33:33 INFO - 2015-12-16 11:33:33,230 DEBUG : BROWSER_OUTPUT: 11:33:33 INFO - 2015-12-16 11:33:33,230 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26526.32 Median:26526.32 stddev:0.00 (0.0%) 11:33:33 INFO - 2015-12-16 11:33:33,230 DEBUG : BROWSER_OUTPUT: Values: 26526.3 11:33:33 INFO - 2015-12-16 11:33:33,230 DEBUG : BROWSER_OUTPUT: 11:33:33 INFO - 2015-12-16 11:33:33,230 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:596.92 Median:596.92 stddev:0.00 (0.0%) 11:33:33 INFO - 2015-12-16 11:33:33,230 DEBUG : BROWSER_OUTPUT: Values: 596.9 11:33:33 INFO - 2015-12-16 11:33:33,230 DEBUG : BROWSER_OUTPUT: 11:33:33 INFO - 2015-12-16 11:33:33,230 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 11:33:33 INFO - 2015-12-16 11:33:33,231 DEBUG : BROWSER_OUTPUT: Values: 4830.9 11:33:33 INFO - 2015-12-16 11:33:33,231 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:33:33 INFO - 2015-12-16 11:33:33,231 DEBUG : BROWSER_OUTPUT: 11:33:34 INFO - 2015-12-16 11:33:34,161 INFO : Browser exited with error code: 0 11:33:34 INFO - 2015-12-16 11:33:34,179 INFO : Completed test v8_7 (00:00:40) 11:33:34 INFO - 2015-12-16 11:33:34,231 INFO : Completed test suite (00:20:16) 11:33:34 INFO - 2015-12-16 11:33:34,231 DEBUG : Working with test: dromaeo_css 11:33:34 INFO - 2015-12-16 11:33:34,231 DEBUG : Generating results file: dromaeo_css 11:33:34 INFO - 2015-12-16 11:33:34,232 DEBUG : Working with test: kraken 11:33:34 INFO - 2015-12-16 11:33:34,233 DEBUG : Generating results file: kraken 11:33:34 INFO - 2015-12-16 11:33:34,233 INFO : javascript benchmark 11:33:34 INFO - 2015-12-16 11:33:34,233 DEBUG : Working with test: v8_7 11:33:34 INFO - 2015-12-16 11:33:34,233 DEBUG : Generating results file: v8_7 11:33:34 INFO - 2015-12-16 11:33:34,234 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:33:34 INFO - 2015-12-16 11:33:34,293 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 11:33:34 INFO - 2015-12-16 11:33:34,293 DEBUG : process_Request line: dromaeo_css 6526.39 graph.html#tests=[[72,132,43]] 11:33:34 INFO - 2015-12-16 11:33:34,293 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:33:34 INFO - 2015-12-16 11:33:34,327 DEBUG : process_Request line: kraken 1552.50 graph.html#tests=[[232,132,43]] 11:33:34 INFO - 2015-12-16 11:33:34,327 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:33:34 INFO - 2015-12-16 11:33:34,367 DEBUG : process_Request line: v8_7 21274.40 graph.html#tests=[[230,132,43]] 11:33:34 INFO - 2015-12-16 11:33:34,368 INFO : javascript benchmark 11:33:34 INFO - 2015-12-16 11:33:34,372 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2688.5698288273875, 2732.357895894466, 2782.8191167574105, 2790.7627851632606, 2791.6370871786676, 4579.633629309656, 4803.159447096761, 4804.303376010481, 4888.193448081062, 4895.339129217555, 4706.552877476643, 4710.411198600175, 4735.90528189436, 4760.880977975552, 4860.902781944359, 4348.478182618091, 4422.823087076513, 4463.218936686083, 4478.2386994211065, 4525.818967241323, 4377.0, 4463.486699029604, 4493.146302202571, 4527.773611319437, 4577.56513131252, 4180.456540649696, 4293.420388247578, 4354.129174165179, 4429.933550996738, 4431.3131464622875, 4383.627391671712, 4437.0460351024685, 4437.245668236407, 4451.755153466558, 4453.153900758878, 4409.581089796464, 4414.3378493225955, 4417.469903611587, 4422.181896349186, 4425.269830478, 4415.66882483815, 4557.156925968707, 4632.444106707217, 4716.457607375127, 4729.385179926622, 5195.584353251768, 5202.219667049935, 5207.9479205207845, 5223.660462069954, 5224.190250511138, 5214.5306922376785, 5227.973860130713, 5238.659487133325, 5245.527902488756, 5276.498732620434, 4633.374494443241, 4737.786799594027, 4765.189917713997, 4840.080384726926, 4843.588294994965, 5241.842744717665, 5270.077736396115, 5278.868028299324, 5284.5772338212855, 5286.81496147633, 5121.897562048738, 5137.306463627438, 5141.9742901286, 5142.100132476801, 5143.639945203875, 4931.9753401232765, 5058.46886076964, 5066.797328106908, 5117.513836185556, 5168.121419358718, 5154.381474223117, 5172.431032586413, 5188.507091826271, 5202.193659982633, 5215.634905556651, 4861.416630004422, 5152.046871328741, 5161.690298582097, 5161.845144645667, 5177.068127737043, 4177.394277829698, 4180.414741936132, 4219.472565929259, 4225.852095176654, 4261.936070958876, 3760.8683696070507, 3767.340715374853, 3770.6417890300377, 3772.905677358088, 3804.1630841214887, 4265.189613973335, 4375.431193944767, 4468.061707041557, 4492.0, 4530.22986092365, 5066.645334826527, 5104.464031276737, 5131.589472842238, 5147.9227811582105, 5182.792688292501, 4421.867343979686, 4466.173757854807, 4473.3960915276675, 4483.618892394118, 4515.796789144496, 4319.719218250803, 4515.458145022552, 4566.88582785433, 4567.977160114245, 4606.792694328763, 4847.636427268039, 4861.319415281863, 4890.119778439915, 4897.608191344755, 4960.975195124001, 5183.766730497212, 5198.948010519997, 5199.506046925536, 5209.322788037683, 5223.712695801767, 4906.190478570996, 4941.0, 4949.480304567968, 4957.157283261926, 4974.477679843564, 4841.12859685246, 4963.205887058053, 4969.850904472872, 4989.575886049726, 5101.0, 5215.061288968022, 5218.060749065205, 5219.9217011744095, 5224.869378265422, 5233.581313494988, 4995.62532810048, 4998.475160108136, 5004.349434573628, 5010.849674509771, 5068.2904393384215, 4825.855224343275, 4935.062338155739, 4960.553550180501, 5028.446870844277, 5068.189089745623, 4911.115999120049, 4920.778564964657, 4924.975375123101, 4932.63005274613, 4947.208446648519, 4817.566419022305, 5028.371453568304, 5056.6713163644245, 5058.241263810458, 5095.464976177448, 4753.263244197155, 4781.569658730731, 4800.423949126127, 4802.423709154924, 4823.5658790709], "unit": "score", "name": "dojo.html", "value": 4710.821623722488}, {"lowerIsBetter": false, "replicates": [562.2830890614464, 573.0945106731365, 575.5913301555895, 579.5971799599278, 582.6911736779506, 35269.82365088174, 35924.28151436969, 36012.639873601256, 36062.27875442489, 36075.27849443016, 39099.21801563967, 39452.80273598635, 39522.8023859881, 39598.20803583926, 39677.60322396775, 7844.058712954454, 7954.801129971739, 8021.438499305051, 8023.839523209533, 8027.397945154107, 7818.569978651172, 7873.842523149534, 7896.960515197445, 7925.128235894047, 7927.4847134936335, 7902.170272121431, 7960.084590272135, 7988.680452781882, 7994.880076798852, 8003.1996800320085, 7814.296713295802, 7850.175731548219, 7921.20787921209, 7973.720919767809, 7990.760277191694, 7826.686932522693, 7964.084130325029, 7970.322522585587, 7979.880301795478, 7981.68073277074, 36388.09029774277, 36590.0, 36611.0, 36830.0, 36935.0, 2406.145818234519, 2690.213796043578, 2845.5447128459555, 2933.164048246261, 3001.3847161331873, 26130.477390452274, 26202.73797262022, 26310.473790524273, 26509.602355964482, 26551.203463896112, 3381.1040074380307, 3499.037764614726, 3512.4906888501023, 3564.7326450516316, 3614.8373323200517, 210504.0, 213108.93445532827, 213738.99999999846, 213988.0, 214022.0, 51797.223041654404, 52566.73716631392, 55085.0, 55518.44481555214, 61858.69070654618, 54268.0, 54505.45494545004, 54539.72730136324, 54840.0, 54842.0, 12516.81224781629, 12541.686457838627, 12598.622041338775, 12634.87365126337, 12641.304728239851, 10927.0, 10978.615748448767, 10979.28634638746, 11022.50398732059, 11034.613788517363, 18905.338313158973, 18989.715154272697, 19070.33253836109, 19109.713354299696, 19160.71258931117, 7536.623168841536, 7701.383889288843, 7791.376689864797, 7843.37253019757, 7845.960770196112, 856.0540602634, 856.6402111113347, 874.6020560644891, 892.5180402582532, 967.4678926590348, 28530.286742831595, 29648.0, 29725.702742972728, 30453.086407407813, 31212.375752484822, 982.8230918434607, 983.4443539400216, 1047.502436342731, 1076.2627600093804, 1107.241539545414, 13443.663908402368, 13684.452621895012, 13686.315684215948, 13691.246981416118, 13761.449542018407, 564283.0, 572922.0, 573657.0, 574023.0, 576610.3508447292, 47604.523954760705, 48172.27741583879, 48196.0, 48229.51770482321, 48286.51713482891, 1236.208826351136, 1264.8355713757153, 1271.8918891894107, 1273.9426725797362, 1274.1781550899618, 26697.19908402751, 26931.0, 27415.314617134733, 27463.862680687267, 27485.450290994468, 39363.60636393714, 39365.01587460222, 39587.604123958394, 39807.80096099501, 39911.60088399195, 243358.0, 244443.0, 244834.0, 245108.0, 245638.0, 29185.0, 38873.61126388813, 39349.0, 39400.802995984835, 39726.60273397345, 34705.438255278066, 35940.64059359478, 36118.8194059028, 38857.61142388653, 39137.41293880537, 37256.44115338326, 37990.81004594959, 38686.22627547377, 39367.80316098516, 39555.80222098871, 32695.346093078482, 36613.81693091624, 38715.41926871043, 38828.80585597054, 38965.0, 33342.0, 33344.66655333416, 33437.83281083579, 35407.468887966184, 36005.27989440249, 27888.302792430353, 29895.55156672695, 30544.694553054185, 30636.693633063383, 30678.0, 24073.27780166598, 24465.38836529101, 24499.38751531226, 24949.251522454357, 25532.10637627674], "unit": "score", "name": "ext.html", "value": 17492.97975195312}, {"lowerIsBetter": false, "replicates": [343.5156429434498, 346.5979463821967, 346.83351991044304, 347.43021444830475, 347.59331582049, 9694.369865958708, 10311.43287119208, 15072.0, 15425.922870385646, 16904.239309231085, 15445.30496127674, 15508.224588770572, 15678.216089195523, 16434.589135271624, 16742.079185644783, 5602.0, 5605.579581531401, 5651.2370829938045, 5704.743286552094, 5723.112917497774, 5702.971485142569, 5727.828165155052, 5732.942670573282, 5738.139279108146, 5750.769969201227, 5746.109353050284, 6057.394260573951, 6083.939160608382, 6257.749690012394, 6290.968545157268, 6134.141220229149, 6160.353162917896, 6175.722092505848, 6550.672466376662, 6564.573302735307, 6245.781397651061, 6284.151639528651, 6311.211098612674, 6311.93688063118, 6322.146510221107, 18880.0, 19394.806051939584, 19933.9003304984, 19963.600727985504, 20138.496537586532, 1973.0923775063488, 1975.594424433507, 2019.7576290845045, 2059.2895451069357, 2083.312506872728, 13572.93213533926, 13598.38807253676, 13958.232297223649, 13999.440022399092, 14011.859881401157, 1920.7407000054955, 1941.2332128809182, 1946.5717542140706, 1955.8435325173953, 1966.6263409952064, 59033.40966590365, 64838.351616483706, 65158.67420662914, 65497.3450265496, 66373.66813165903, 15191.696166076617, 15497.612559685873, 15520.456784012731, 15536.300866461037, 15545.844541554667, 23199.188028418925, 23233.7676623235, 23254.883725581603, 23556.411089722893, 23593.410164745674, 8090.919090809134, 8201.753947381589, 8212.753617391489, 8215.26062654352, 8248.54632995191, 6735.865282694416, 6785.491088168407, 6786.728530858711, 6789.1174147360525, 6813.182418109858, 7601.277878601634, 7620.237976202336, 7660.502067365604, 7707.34487568563, 7759.418043646749, 1647.250501022032, 1740.1560243282, 3123.859426325821, 3189.4418476766473, 3221.5167724841463, 781.6521647866645, 828.0146625515617, 863.1325517854516, 876.9956150219208, 961.9754960966549, 15081.170535620646, 15571.766423503657, 15842.44551440694, 16204.675906481805, 16422.09678467672, 794.5431376958272, 878.5124256037833, 880.1682410122501, 926.1248120526038, 947.6541062512272, 8423.157684231528, 8697.0, 8710.303175745925, 8794.560271986375, 8891.19979201875, 500008.0, 504880.0, 512917.0, 513764.2935355973, 518610.0, 72859.63570182116, 74510.0, 74666.62666686632, 75841.0, 76157.61921190358, 1033.9379637221791, 1047.1256500821746, 1049.884512703602, 1057.8677665291839, 1079.5088234852965, 14886.776698349317, 14900.925495372454, 14925.626859328604, 15195.0, 15504.844951550791, 33808.32383352368, 34003.0, 34382.65617343895, 34817.651823482454, 34935.825320873235, 44298.3355249678, 46572.53427465682, 46715.766421167675, 46822.0, 47302.52697473119, 8407.201315874981, 8498.192671696179, 8559.10129436425, 8563.914360856561, 8579.0, 10455.0, 12835.743285134058, 15729.44946926852, 16382.26279817435, 16555.834441655912, 11732.765344692887, 13422.597322080353, 13478.663033424244, 13622.455101795817, 14232.71905528466, 13544.32278386057, 13778.931105344409, 14087.859121408655, 14099.154050756988, 14254.572362829133, 14430.927845360706, 14654.340554674853, 14724.55826325212, 14918.477853275082, 15098.924505377403, 8641.222289993932, 8780.209781119729, 8845.159709827556, 8888.377813552988, 8902.0, 9741.707748767549, 11073.0, 13979.650508737363, 14202.857971420153, 14428.783568246694], "unit": "score", "name": "jquery.html", "value": 9254.08859810416}, {"lowerIsBetter": false, "replicates": [1479.9926000369996, 1692.9238184281705, 1708.9829101708979, 1753.9473815785516, 1778.8754787164903, 7070.328318809711, 7101.11236095488, 7304.233055529173, 7333.853322933538, 7337.88993165103, 7390.778276651709, 7446.664900079496, 7467.85064298715, 7504.137024242214, 7507.774766756992, 2122.045079714131, 2157.870527768331, 2159.211887661, 2160.1899287767087, 2168.29530402619, 2103.5056761661, 2117.915283388663, 2124.7875212478707, 2129.669901165314, 2135.1993002624017, 1991.4324417541004, 2026.0882602828785, 2030.3908827351809, 2037.7554693436734, 2066.628006958747, 2069.430906500709, 2097.758757742864, 2099.149844313048, 2099.496120930973, 2105.7473103227558, 2075.9273425430188, 2113.8520303578757, 2119.6926445665445, 2129.936101916945, 2139.721836161289, 7194.064771579661, 7315.853682926365, 7328.706851725925, 7337.119545654556, 7337.633118344115, 4113.280175969194, 4203.243416185085, 4212.49450065994, 4213.367994800774, 4239.6396306314, 2720.3949669694975, 2793.706660800607, 2820.562812764025, 2858.571214317869, 2863.3557449573887, 850.8893843800329, 886.9423487473293, 896.5024411451642, 899.1727610598265, 915.3638221436105, 9784.461854597994, 9800.264980126447, 9876.111149996463, 9887.060729230712, 9899.208063354914, 3692.1508053147927, 3760.191558814868, 3793.0517370657335, 3843.7117216208335, 3848.7113466490127, 7480.326770590673, 7507.0, 7584.431167662337, 7616.543007419462, 7625.6568454419685, 4239.724417912826, 4245.108527209259, 4258.425112609758, 4265.402843601898, 4274.422952901318, 3898.6101389861356, 3926.6662333701956, 3929.980350098231, 3934.2918274710255, 3945.072907866649, 3043.1022848259818, 3112.1752735525106, 3130.0453361724894, 3141.2932090279505, 3163.4147682678777, 924.8797656304637, 931.9627214911463, 933.808569243317, 934.359963425056, 936.3071327217809, 834.8079941613463, 872.8777971084053, 976.8144052629978, 1030.8144533983805, 1129.108004676313, 6625.701843417058, 6675.46596272297, 6707.49693772969, 6707.832304192434, 6713.865722685519, 568.3151802078486, 579.9478046975793, 593.4688453833794, 596.1326270276824, 738.346563291491, 5188.662736922163, 5271.868203294948, 5278.049951008778, 5301.867453313621, 5310.150375939831, 8346.457480263764, 8392.706255281159, 8509.914900850912, 8511.233988940901, 8565.700200493078, 8293.087760346358, 8355.289800366916, 8368.49789012649, 8379.203975622306, 8410.579471026424, 6711.127553418024, 6731.596104233761, 6845.965770171118, 6885.9999999999, 6893.75871844493, 6689.565178263398, 6705.0, 6749.122614060338, 6755.3582409671, 6773.05177275172, 7470.6264686766535, 7601.809954751176, 7619.238076192337, 7642.197569255148, 7723.459357845121, 7697.0, 7858.882116768139, 7898.644560994884, 7969.0, 7980.162082981204, 6237.75048998035, 6368.299487056513, 6422.518311126591, 6466.870662586816, 6506.837329066811, 6639.867202656016, 6658.0, 6660.134182556237, 6662.866742665023, 6669.83325416849, 6181.196444462191, 6264.0, 6320.209973753281, 6333.1766870306565, 6425.389587989321, 5856.472917437451, 6297.559170857996, 6340.207474065742, 6401.167848179707, 6444.8388790280615, 6352.428281454691, 6358.141650877073, 6361.777337793155, 6363.172787537591, 6418.582792118497, 5843.94156058434, 5936.614120082181, 5989.700514974321, 6000.21997140369, 6003.489703375088, 5910.054391297544, 6141.570090093651, 6165.167702360124, 6174.166487524127, 6179.907301390573], "unit": "score", "name": "mootools.html", "value": 4032.044582971141}, {"lowerIsBetter": false, "replicates": [296.6514345643868, 306.3490083572408, 309.80172689478735, 312.651393696029, 313.6330493322812, 5635.436456354362, 5684.772609095631, 5711.571632127586, 5748.913766293504, 5825.155352473888, 5625.831225063254, 5654.180143879135, 5687.8578035549135, 5696.401877802833, 5705.286839145107, 4163.791810409482, 4302.720323178999, 4340.717853339539, 4343.674224433164, 4351.717138385995, 4259.659227261812, 4271.508776490697, 4281.593248641374, 4290.356446533014, 4290.811686040126, 4197.433346498215, 4200.57994200579, 4208.116295577933, 4208.494980602332, 4222.577742225768, 4240.533541310453, 4241.045764702917, 4241.809118589671, 4243.151369726067, 4249.4475718156755, 3629.1471504196493, 3669.5596528416495, 3669.9082522936874, 3672.467492213614, 3673.7244706647107, 5286.101362768339, 5402.8109016184635, 5421.701806400646, 5435.782568697247, 5450.073487507094, 4908.239222920453, 4917.360743103373, 4918.409790825088, 4936.8765780855765, 4937.901241975176, 5922.2597175353085, 5933.821985340447, 5937.346891841894, 5947.345791962881, 5957.970210148965, 3895.14306852492, 4013.137175507251, 4042.514898212233, 4043.353063509824, 4046.332355161395, 6130.295016073164, 6218.595791273553, 6225.159603453521, 6248.656323902183, 6256.906146407762, 4094.7952602369764, 4095.7337773044655, 4097.262492751273, 4103.671706263492, 4108.281050816096, 4148.336266197394, 4148.771817550003, 4149.564295748964, 4164.8542301019315, 4170.416141740159, 4627.305904114342, 4635.814567417333, 4804.25534042224, 4810.326554282403, 4831.73425461596, 5842.678652674143, 5865.706714664335, 5873.148393483007, 5875.11873219012, 5906.675132867734, 1411.1744629391715, 1458.9860047267048, 1460.5107289058071, 1468.0, 1471.3452513631332, 983.3902980152351, 1006.5168719014767, 1012.2863381316155, 1013.2501948558014, 1014.1785154025263, 5121.0014047261175, 5127.410347809975, 5136.383633963948, 5155.484451554815, 5160.690358578498, 6113.449789518964, 6115.602485838406, 6116.174316467309, 6128.724207410677, 6145.262568491809, 5128.820491282787, 5129.666571672829, 5135.255387968724, 5138.897222055538, 5142.408623008402, 3209.791363561361, 3274.9017529474154, 3302.570665813429, 3307.7849939753837, 3311.9006429807146, 5764.7117644117625, 5790.305163380422, 5855.2973643163095, 5860.619059761102, 5865.35481097079, 6378.649174295459, 6387.393197646216, 6389.233292004989, 6396.648184349812, 6397.232332120176, 5710.400407957105, 5838.532917366516, 5842.328132264759, 5848.210491583667, 5850.5612079094235, 6164.753409863555, 6170.81487555374, 6171.228596425447, 6172.506199503939, 6186.845328866814, 5978.8206353809455, 5999.310079340931, 6021.819345419644, 6025.427584379477, 6031.306399764083, 5719.084946408555, 5826.388229235869, 5828.708564571839, 5840.386759390203, 5843.211166492469, 4109.486314210723, 4173.08192197716, 4174.415581818608, 4175.561566035522, 4181.853635122756, 5922.496587790086, 6094.421030002142, 6182.907256391068, 6185.752569897334, 6189.473894718999, 5766.452187042224, 5892.086726557391, 5923.437273459014, 5927.170196172453, 5940.702964851654, 5916.763329466773, 5920.555958303058, 5922.7927022554, 5931.288245410578, 5935.228420305332, 5671.347795003628, 5753.769849205984, 5782.739776710142, 5793.073108302651, 5799.0, 5918.0, 5926.199963005111, 5941.168236446987, 5967.46292833647, 5996.4902983245165, 5794.275715535558, 5820.708964551671, 5822.0684690449325, 5822.0684690449325, 5824.592278540462], "unit": "score", "name": "prototype.html", "value": 4398.804035639553}, {"lowerIsBetter": false, "replicates": [699.8425354295284, 709.8899670551064, 753.2580408297829, 764.4763337114077, 771.8726410142331, 11152.944235278823, 11316.377599232039, 11338.659840204786, 11345.035671967882, 11348.943255283722, 11459.140564457679, 11532.192746507748, 11534.077273818095, 11544.018758405524, 11583.826242606368, 620.0915658560208, 629.0187307799847, 780.3094261578516, 788.0897563314367, 813.808754942588, 808.3250485844327, 813.1177672225642, 816.9060558035812, 818.1164342510075, 819.635262308273, 851.8168593752373, 858.2833334165979, 859.8065435277044, 860.5095095795399, 862.4954401674996, 840.9663613455485, 844.1389782421926, 849.3841964575695, 849.570966661838, 850.2432834777053, 630.3444417805476, 631.8957372033609, 632.1213513216633, 632.5192853431425, 636.6466611030876, 11588.710282242928, 11650.883491165065, 11688.883111168865, 11698.824517632242, 11708.180427370002, 10967.341959482377, 11233.26983746062, 11359.829602555968, 11416.372099534523, 11686.415679216005, 9216.907830921671, 9310.255179585616, 9404.576794044284, 9416.293777966679, 9417.1524562789, 3148.622165340174, 3225.629052658951, 3251.219707270238, 3251.4472539668313, 3252.073159149631, 37851.242975140616, 38015.61984380176, 38130.61869381298, 38172.42741358854, 38389.040273993094, 9058.728238152735, 9164.404313719588, 9251.444913305224, 9325.393849399767, 9399.530023498797, 16314.0, 16370.508884733477, 16399.83600164007, 16475.505734827973, 16497.422590209284, 5988.640681559121, 6125.601835880653, 6205.193324867739, 6330.746770129143, 6360.395762402564, 3467.063892748994, 3559.875404360835, 3567.8037707926314, 3570.0539357070397, 3576.213233088716, 2539.250920978279, 2560.5263026340185, 2566.0762125634756, 2571.7299683533333, 2579.7678208961283, 505.53490788474693, 520.4587229281581, 521.9112750832368, 532.0317023018147, 532.6724064700181, 565.3724365953788, 580.4456743809652, 587.8618524646705, 596.9015112506474, 625.6277514878731, 7782.883256751154, 7895.486793358414, 7916.366690664733, 7956.0, 7970.7652193854265, 500.37453183520597, 597.9356744993918, 603.9389912533032, 616.9722362493699, 619.8791235709084, 3548.4854696068924, 3657.3782456982376, 3806.467094606757, 3813.866514671973, 3830.214805964826, 48127.278090828666, 48585.75707121513, 49555.25667114996, 50151.0, 51627.0, 42260.78869605633, 42606.786966064974, 43153.784231078644, 43220.56779432228, 44193.0, 38944.41583376252, 39158.80420597936, 39452.80273598671, 40456.59543404587, 40981.385279220834, 7866.842663146819, 8061.717839875576, 8160.795980100307, 8419.747407577783, 8481.109483504144, 29559.85220073972, 30286.54570181405, 30590.541141882444, 31001.8449907749, 31128.22179445532, 37123.44314835226, 38372.6162738369, 38681.613183868925, 38733.41899871448, 38807.805960970014, 10121.797564048826, 10137.64518241858, 10268.0, 10347.379157250589, 10397.11624511925, 11025.283356581796, 11144.0, 11189.664310070712, 11312.321260724382, 11518.596849110576, 10365.471008357286, 10437.112845408225, 10455.477226138815, 10697.893021069689, 10730.141588672732, 10232.283740138118, 10369.74075648115, 10701.357918524913, 11014.889851101387, 11017.669469915916, 9655.324127311022, 10527.789444211227, 10910.781784364426, 11117.888821111685, 11190.32858028521, 9081.137291957253, 9108.954455227682, 9230.538473076454, 9271.536423178948, 9355.204807591432, 9009.504477253813, 9049.954750226207, 9243.953780231055, 9258.675946341846, 9321.720348389288], "unit": "score", "name": "yui.html", "value": 5712.644937453513}], "name": "dromaeo_css", "value": 6526.390689945402}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 111.0, 116.0, 117.0, 115.0, 128.0, 115.0, 114.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 116.0}, {"lowerIsBetter": true, "replicates": [155.0, 130.0, 160.0, 169.0, 133.0, 163.0, 154.0, 142.0, 166.0, 139.0], "unit": "score", "name": "audio-beat-detection", "value": 151.1}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 166.0, 162.0, 162.0, 165.0, 166.0, 161.0, 164.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 81.0, 133.0, 72.0, 71.0, 72.0, 74.0, 87.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 128.0, 94.0, 94.0, 95.0, 129.0, 94.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 113.0, 113.0, 109.0, 110.0, 112.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.6}, {"lowerIsBetter": true, "replicates": [151.0, 147.0, 149.0, 146.0, 148.0, 148.0, 149.0, 148.0, 149.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 74.0, 75.0, 77.0, 74.0, 75.0, 75.0, 75.0, 73.0], "unit": "score", "name": "json-parse-financial", "value": 74.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 94.0, 85.0, 85.0, 84.0, 86.0, 86.0, 97.0, 99.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.9}, {"lowerIsBetter": true, "replicates": [134.0, 130.0, 129.0, 130.0, 125.0, 125.0, 140.0, 125.0, 124.0, 137.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.9}, {"lowerIsBetter": true, "replicates": [142.0, 156.0, 152.0, 154.0, 146.0, 142.0, 144.0, 153.0, 140.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.0}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 73.0, 72.0, 73.0, 70.0, 70.0, 72.0, 73.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.7}], "name": "kraken", "value": 1552.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.92002654720426], "unit": "score", "name": "Richards", "value": 212.765154}, {"lowerIsBetter": false, "replicates": [185.97731076808628], "unit": "score", "name": "DeltaBlue", "value": 355.5164860000001}, {"lowerIsBetter": false, "replicates": [277.700638711469], "unit": "score", "name": "Encrypt", "value": 958.5177809999998}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1086.9565217391305], "unit": "score", "name": "RayTrace", "value": 680.7898799999998}, {"lowerIsBetter": false, "replicates": [720.1438848920864], "unit": "score", "name": "Earley", "value": 925.4581118881117}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [26526.315789473683], "unit": "score", "name": "RegExp", "value": 34.34268849206351}, {"lowerIsBetter": false, "replicates": [596.9176052163604], "unit": "score", "name": "Splay", "value": 136.51967924528304}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21274.40120274468}]} 11:33:34 INFO - RETURN: dromaeo_css: 6526.39 11:33:34 INFO - RETURN: kraken: 1552.50 11:33:34 INFO - RETURN: v8_7: 21274.40 11:33:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21274.40"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1552.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6526.39"}}} 11:33:34 INFO - Return code: 0 11:33:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:33:34 INFO - # TBPL SUCCESS # 11:33:34 INFO - Running post-action listener: _resource_record_post_action 11:33:34 INFO - Running post-run listener: _resource_record_post_run 11:33:35 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 524238848; Read time: 8; Write time: 480300 11:33:35 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 244133888; Read time: 0; Write time: 295848 11:33:35 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275456000; Read time: 8; Write time: 184072 11:33:35 INFO - Running post-run listener: _upload_blobber_files 11:33:35 INFO - Blob upload gear active. 11:33:35 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:33:35 INFO - Copying logs to upload dir... 11:33:35 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.518879 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-16 11:33:35.561045) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 11:33:35.564861) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010041 build_url: 'https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.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-16 11:33:35.615457) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:33:35.615803) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5400c60ebd4f8d7cf28c0934000001b8-1450284315.657426-2105561041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:33:35.665059) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 11:33:35.665359) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 11:33:35.665683) ========= ========= Total master_lag: 0.24 =========