builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-065 starttime: 1449770303.99 results: success (0) buildid: 20151210085453 builduid: 9e10ebd8713c488886db737e60aa1182 revision: bfa8b0451cfcc7d2825c9147e78c48657c9cd1c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 09:58:23.994104) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 09:58:23.994755) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 09:58:23.995115) ========= 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=20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006505 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 09:58:24.019097) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 09:58:24.019898) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 09:58:24.041077) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 09:58:24.041487) ========= 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=20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 09:58:24.093224) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 09:58:24.093540) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 09:58:24.093994) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 09:58:24.094315) ========= 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=20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-10 09:58:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-12-10 09:58:26 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131822 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 09:58:24.241396) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 09:58:24.241743) ========= 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=20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021860 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 09:58:24.295913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-10 09:58:24.296271) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bfa8b0451cfcc7d2825c9147e78c48657c9cd1c0 --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 bfa8b0451cfcc7d2825c9147e78c48657c9cd1c0 --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=20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-10 09:58:26,854 truncating revision to first 12 chars 2015-12-10 09:58:26,854 Setting DEBUG logging. 2015-12-10 09:58:26,854 attempt 1/10 2015-12-10 09:58:26,854 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bfa8b0451cfc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-10 09:58:28,194 unpacking tar archive at: fx-team-bfa8b0451cfc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.619349 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-10 09:58:25.930358) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 09:58:25.930692) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 09:58:25.939132) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 09:58:25.939420) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 09:58:25.939880) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-10 09:58:25.940215) ========= /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=20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:58:28 INFO - MultiFileLogger online at 20151210 09:58:28 in /builds/slave/test 09:58:28 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 09:58:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:58:28 INFO - {'append_to_log': False, 09:58:28 INFO - 'base_work_dir': '/builds/slave/test', 09:58:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:58:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:58:28 INFO - 'branch': 'Fx-Team-Non-PGO', 09:58:28 INFO - 'buildbot_json_path': 'buildprops.json', 09:58:28 INFO - 'config_files': ('talos/linux_config.py',), 09:58:28 INFO - 'default_actions': ('clobber', 09:58:28 INFO - 'read-buildbot-config', 09:58:28 INFO - 'download-and-extract', 09:58:28 INFO - 'populate-webroot', 09:58:28 INFO - 'create-virtualenv', 09:58:28 INFO - 'install', 09:58:28 INFO - 'run-tests'), 09:58:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:58:28 INFO - 'download_minidump_stackwalk': True, 09:58:28 INFO - 'download_symbols': 'ondemand', 09:58:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:58:28 INFO - 'tooltool.py': '/tools/tooltool.py', 09:58:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:58:28 INFO - '/tools/misc-python/virtualenv.py')}, 09:58:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:58:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:58:28 INFO - 'installer_path': 'installer.exe', 09:58:28 INFO - 'log_level': 'info', 09:58:28 INFO - 'log_name': 'talos', 09:58:28 INFO - 'log_to_console': True, 09:58:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:58:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:58:28 INFO - 'opt_config_files': (), 09:58:28 INFO - 'pip_index': False, 09:58:28 INFO - 'sps_profile': False, 09:58:28 INFO - 'sps_profile_interval': 0, 09:58:28 INFO - 'suite': 'dromaeojs-e10s', 09:58:28 INFO - 'system_bits': '64', 09:58:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:58:28 INFO - 'title': 'talos-linux64-ix-065', 09:58:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:58:28 INFO - 'use_talos_json': True, 09:58:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:58:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:58:28 INFO - 'work_dir': 'build'} 09:58:28 INFO - ##### 09:58:28 INFO - ##### Running clobber step. 09:58:28 INFO - ##### 09:58:28 INFO - Running pre-action listener: _resource_record_pre_action 09:58:28 INFO - Running main action method: clobber 09:58:28 INFO - rmtree: /builds/slave/test/build 09:58:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:58:29 INFO - Running post-action listener: _resource_record_post_action 09:58:29 INFO - ##### 09:58:29 INFO - ##### Running read-buildbot-config step. 09:58:29 INFO - ##### 09:58:29 INFO - Running pre-action listener: _resource_record_pre_action 09:58:29 INFO - Running main action method: read_buildbot_config 09:58:29 INFO - Using buildbot properties: 09:58:29 INFO - { 09:58:29 INFO - "properties": { 09:58:29 INFO - "buildnumber": 561, 09:58:29 INFO - "product": "firefox", 09:58:29 INFO - "script_repo_revision": "production", 09:58:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:58:29 INFO - "repository": "", 09:58:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:58:29 INFO - "buildid": "20151210085453", 09:58:29 INFO - "slavename": "talos-linux64-ix-065", 09:58:29 INFO - "pgo_build": "False", 09:58:29 INFO - "basedir": "/builds/slave/test", 09:58:29 INFO - "project": "", 09:58:29 INFO - "platform": "ubuntu64_hw", 09:58:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:58:29 INFO - "slavebuilddir": "test", 09:58:29 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:58:29 INFO - "branch": "fx-team", 09:58:29 INFO - "repo_path": "integration/fx-team", 09:58:29 INFO - "stage_platform": "linux64", 09:58:29 INFO - "builduid": "9e10ebd8713c488886db737e60aa1182", 09:58:29 INFO - "revision": "bfa8b0451cfcc7d2825c9147e78c48657c9cd1c0" 09:58:29 INFO - }, 09:58:29 INFO - "sourcestamp": { 09:58:29 INFO - "repository": "", 09:58:29 INFO - "hasPatch": false, 09:58:29 INFO - "project": "", 09:58:29 INFO - "branch": "fx-team-linux64-talos", 09:58:29 INFO - "changes": [ 09:58:29 INFO - { 09:58:29 INFO - "category": null, 09:58:29 INFO - "files": [ 09:58:29 INFO - { 09:58:29 INFO - "url": null, 09:58:29 INFO - "name": "https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:58:29 INFO - } 09:58:29 INFO - ], 09:58:29 INFO - "repository": "", 09:58:29 INFO - "rev": "bfa8b0451cfcc7d2825c9147e78c48657c9cd1c0", 09:58:29 INFO - "who": "gijskruitbosch@gmail.com", 09:58:29 INFO - "when": 1449770259, 09:58:29 INFO - "number": 7258530, 09:58:29 INFO - "comments": "Bug 1224605 - also show the OSK when tapping in focused inputs, r=masayuki", 09:58:29 INFO - "project": "", 09:58:29 INFO - "at": "Thu 10 Dec 2015 09:57:39", 09:58:29 INFO - "branch": "fx-team-linux64-talos", 09:58:29 INFO - "revlink": "", 09:58:29 INFO - "properties": [ 09:58:29 INFO - [ 09:58:29 INFO - "buildid", 09:58:29 INFO - "20151210085453", 09:58:29 INFO - "Change" 09:58:29 INFO - ], 09:58:29 INFO - [ 09:58:29 INFO - "builduid", 09:58:29 INFO - "9e10ebd8713c488886db737e60aa1182", 09:58:29 INFO - "Change" 09:58:29 INFO - ], 09:58:29 INFO - [ 09:58:29 INFO - "pgo_build", 09:58:29 INFO - "False", 09:58:29 INFO - "Change" 09:58:29 INFO - ] 09:58:29 INFO - ], 09:58:29 INFO - "revision": "bfa8b0451cfcc7d2825c9147e78c48657c9cd1c0" 09:58:29 INFO - } 09:58:29 INFO - ], 09:58:29 INFO - "revision": "bfa8b0451cfcc7d2825c9147e78c48657c9cd1c0" 09:58:29 INFO - } 09:58:29 INFO - } 09:58:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:58:29 INFO - Running post-action listener: _resource_record_post_action 09:58:29 INFO - ##### 09:58:29 INFO - ##### Running download-and-extract step. 09:58:29 INFO - ##### 09:58:29 INFO - Running pre-action listener: _resource_record_pre_action 09:58:29 INFO - Running main action method: download_and_extract 09:58:29 INFO - mkdir: /builds/slave/test/build/tests 09:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:29 INFO - https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:58:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/test_packages.json 09:58:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/test_packages.json 09:58:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:58:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:58:30 INFO - Downloaded 1302 bytes. 09:58:30 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:58:30 INFO - Using the following test package requirements: 09:58:30 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:58:30 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:58:30 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:30 INFO - u'jsshell-linux-x86_64.zip'], 09:58:30 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:58:30 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:58:30 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:58:30 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:58:30 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:58:30 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:58:30 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:58:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:58: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')]} 09:58:30 INFO - https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:58:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:58:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:58:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:58:31 INFO - Downloaded 21866925 bytes. 09:58:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 09:58:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:58:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:58:32 INFO - Return code: 0 09:58:32 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:58:32 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')]} 09:58:32 INFO - https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:58:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:58:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:58:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:58:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:58:33 INFO - Downloaded 21866925 bytes. 09:58:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 09:58:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:58:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:58:34 INFO - Return code: 0 09:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:34 INFO - https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:58:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:58:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:58:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:58:35 INFO - Downloaded 11132038 bytes. 09:58:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 09:58:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:58:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 09:58:36 INFO - Return code: 0 09:58: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')]} 09:58:36 INFO - https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:58:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:58:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:58:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:58:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:58:37 INFO - Downloaded 57727468 bytes. 09:58:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:58:37 INFO - mkdir: /builds/slave/test/properties 09:58:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:58:37 INFO - Writing to file /builds/slave/test/properties/build_url 09:58:37 INFO - Contents: 09:58:37 INFO - build_url:https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:58:37 INFO - Running post-action listener: _resource_record_post_action 09:58:37 INFO - Running post-action listener: set_extra_try_arguments 09:58:37 INFO - ##### 09:58:37 INFO - ##### Running populate-webroot step. 09:58:37 INFO - ##### 09:58:37 INFO - Running pre-action listener: _resource_record_pre_action 09:58:37 INFO - Running main action method: populate_webroot 09:58:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:58:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:58:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:58:37 INFO - '--tppagecycles', 09:58:37 INFO - '7'], 09:58:37 INFO - 'tests': ['tsvgm']}}, 09:58:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:58:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:58:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:58:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:58:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:58:37 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:58:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:37 INFO - 'talos_options': ['--e10s'], 09:58:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:37 INFO - 'tests': ['damp', 'tps']}, 09:58:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:37 INFO - 'talos_options': ['--e10s'], 09:58:37 INFO - 'tests': ['damp', 'tps']}, 09:58:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:58:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:58:37 INFO - 'other': {'tests': ['a11yr', 09:58:37 INFO - 'ts_paint', 09:58:37 INFO - 'tpaint', 09:58:37 INFO - 'sessionrestore', 09:58:37 INFO - 'sessionrestore_no_auto_restore']}, 09:58:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:58:37 INFO - 'tests': ['a11yr', 09:58:37 INFO - 'ts_paint', 09:58:37 INFO - 'tpaint', 09:58:37 INFO - 'sessionrestore', 09:58:37 INFO - 'sessionrestore_no_auto_restore']}, 09:58:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:58:37 INFO - 'tests': ['a11yr', 09:58:37 INFO - 'ts_paint', 09:58:37 INFO - 'tpaint', 09:58:37 INFO - 'sessionrestore', 09:58:37 INFO - 'sessionrestore_no_auto_restore']}, 09:58:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:58:37 INFO - 'tests': ['a11yr', 09:58:37 INFO - 'ts_paint', 09:58:37 INFO - 'tpaint', 09:58:37 INFO - 'sessionrestore', 09:58:37 INFO - 'sessionrestore_no_auto_restore']}, 09:58:37 INFO - 'other_l64': {'tests': ['a11yr', 09:58:37 INFO - 'ts_paint', 09:58:37 INFO - 'tpaint', 09:58:37 INFO - 'sessionrestore', 09:58:37 INFO - 'sessionrestore_no_auto_restore']}, 09:58:37 INFO - 'other_nol64': {'tests': ['a11yr', 09:58:37 INFO - 'ts_paint', 09:58:37 INFO - 'tpaint', 09:58:37 INFO - 'sessionrestore', 09:58:37 INFO - 'sessionrestore_no_auto_restore']}, 09:58:37 INFO - 'svgr': {'tests': ['tsvgx', 09:58:37 INFO - 'tsvgr_opacity', 09:58:37 INFO - 'tart', 09:58:37 INFO - 'tscrollx', 09:58:37 INFO - 'cart']}, 09:58:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:58:37 INFO - 'tests': ['tsvgx', 09:58:37 INFO - 'tsvgr_opacity', 09:58:37 INFO - 'tart', 09:58:37 INFO - 'tscrollx', 09:58:37 INFO - 'cart']}, 09:58:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:37 INFO - 'tests': ['tp5o']}, 09:58:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:37 INFO - 'talos_options': ['--e10s'], 09:58:37 INFO - 'tests': ['tp5o']}, 09:58:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:37 INFO - 'talos_options': ['--xperf_path', 09:58:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:37 INFO - 'tests': ['tp5n']}, 09:58:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:37 INFO - 'talos_options': ['--e10s', 09:58:37 INFO - '--xperf_path', 09:58:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:37 INFO - 'tests': ['tp5n']}}, 09:58:37 INFO - 'talos.zip': {'path': '', 09:58:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:58:37 INFO - Running post-action listener: _resource_record_post_action 09:58:37 INFO - ##### 09:58:37 INFO - ##### Running create-virtualenv step. 09:58:37 INFO - ##### 09:58:37 INFO - Running pre-action listener: _resource_record_pre_action 09:58:37 INFO - Running main action method: create_virtualenv 09:58:37 INFO - Creating virtualenv /builds/slave/test/build/venv 09:58:37 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 09:58:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:58:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:58:38 INFO - Using real prefix '/usr' 09:58:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:58:38 INFO - Installing distribute.............................................................................................................................................................................................done. 09:58:40 INFO - Installing pip.................done. 09:58:40 INFO - Return code: 0 09:58:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:40 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 0x7fb23497df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fa0b0>, '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 0x20fafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20fb440>, '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': '20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892', '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 09:58:40 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 09:58:40 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 09:58:40 INFO - Using env: {'DISPLAY': ':0', 09:58:40 INFO - 'HOME': '/home/cltbld', 09:58:40 INFO - 'LANG': 'en_US.UTF-8', 09:58:40 INFO - 'LANGUAGE': 'en_US:en', 09:58:40 INFO - 'LOGNAME': 'cltbld', 09:58:40 INFO - 'MAIL': '/var/mail/cltbld', 09:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:40 INFO - 'MOZ_NO_REMOTE': '1', 09:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:40 INFO - 'NO_EM_RESTART': '1', 09:58:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:40 INFO - 'PWD': '/builds/slave/test', 09:58:40 INFO - 'SHELL': '/bin/bash', 09:58:40 INFO - 'SHLVL': '1', 09:58:40 INFO - 'TERM': 'linux', 09:58:40 INFO - 'TMOUT': '86400', 09:58:40 INFO - 'USER': 'cltbld', 09:58:40 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892', 09:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:40 INFO - '_': '/tools/buildbot/bin/python'} 09:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:40 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 09:58:40 INFO - Cleaning up... 09:58:40 INFO - Return code: 0 09:58:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:40 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 0x7fb23497df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fa0b0>, '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 0x20fafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20fb440>, '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': '20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892', '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 09:58:40 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 09:58:40 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 09:58:40 INFO - Using env: {'DISPLAY': ':0', 09:58:40 INFO - 'HOME': '/home/cltbld', 09:58:40 INFO - 'LANG': 'en_US.UTF-8', 09:58:40 INFO - 'LANGUAGE': 'en_US:en', 09:58:40 INFO - 'LOGNAME': 'cltbld', 09:58:40 INFO - 'MAIL': '/var/mail/cltbld', 09:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:40 INFO - 'MOZ_NO_REMOTE': '1', 09:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:40 INFO - 'NO_EM_RESTART': '1', 09:58:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:40 INFO - 'PWD': '/builds/slave/test', 09:58:40 INFO - 'SHELL': '/bin/bash', 09:58:40 INFO - 'SHLVL': '1', 09:58:40 INFO - 'TERM': 'linux', 09:58:40 INFO - 'TMOUT': '86400', 09:58:40 INFO - 'USER': 'cltbld', 09:58:40 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892', 09:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:40 INFO - '_': '/tools/buildbot/bin/python'} 09:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:40 INFO - Downloading/unpacking psutil>=0.7.1 09:58:40 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 09:58:40 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 09:58:40 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 09:58:40 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 09:58:40 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 09:58:40 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 09:58:42 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:58:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:58:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:58:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:42 INFO - Installing collected packages: psutil 09:58:42 INFO - Running setup.py install for psutil 09:58:42 INFO - building 'psutil._psutil_linux' extension 09:58:42 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 09:58:43 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 09:58:43 INFO - building 'psutil._psutil_posix' extension 09:58:43 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 09:58:43 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 09:58:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:43 INFO - Successfully installed psutil 09:58:43 INFO - Cleaning up... 09:58:43 INFO - Return code: 0 09:58:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:58:43 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')]} 09:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:43 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')]} 09:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:43 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 0x7fb23497df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fa0b0>, '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 0x20fafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20fb440>, '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': '20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892', '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 09:58:43 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 09:58:43 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 09:58:43 INFO - Using env: {'DISPLAY': ':0', 09:58:43 INFO - 'HOME': '/home/cltbld', 09:58:43 INFO - 'LANG': 'en_US.UTF-8', 09:58:43 INFO - 'LANGUAGE': 'en_US:en', 09:58:43 INFO - 'LOGNAME': 'cltbld', 09:58:43 INFO - 'MAIL': '/var/mail/cltbld', 09:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:43 INFO - 'MOZ_NO_REMOTE': '1', 09:58:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:43 INFO - 'NO_EM_RESTART': '1', 09:58:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:43 INFO - 'PWD': '/builds/slave/test', 09:58:43 INFO - 'SHELL': '/bin/bash', 09:58:43 INFO - 'SHLVL': '1', 09:58:43 INFO - 'TERM': 'linux', 09:58:43 INFO - 'TMOUT': '86400', 09:58:43 INFO - 'USER': 'cltbld', 09:58:43 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892', 09:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:43 INFO - '_': '/tools/buildbot/bin/python'} 09:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:58:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:58:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:58:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:58:45 INFO - Installing collected packages: mozsystemmonitor 09:58:45 INFO - Running setup.py install for mozsystemmonitor 09:58:45 INFO - Successfully installed mozsystemmonitor 09:58:45 INFO - Cleaning up... 09:58:45 INFO - Return code: 0 09:58:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:58:45 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')]} 09:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:45 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')]} 09:58:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:45 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 0x7fb23497df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fa0b0>, '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 0x20fafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20fb440>, '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': '20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892', '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 09:58:45 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 09:58:45 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 09:58:45 INFO - Using env: {'DISPLAY': ':0', 09:58:45 INFO - 'HOME': '/home/cltbld', 09:58:45 INFO - 'LANG': 'en_US.UTF-8', 09:58:45 INFO - 'LANGUAGE': 'en_US:en', 09:58:45 INFO - 'LOGNAME': 'cltbld', 09:58:45 INFO - 'MAIL': '/var/mail/cltbld', 09:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:45 INFO - 'MOZ_NO_REMOTE': '1', 09:58:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:45 INFO - 'NO_EM_RESTART': '1', 09:58:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:45 INFO - 'PWD': '/builds/slave/test', 09:58:45 INFO - 'SHELL': '/bin/bash', 09:58:45 INFO - 'SHLVL': '1', 09:58:45 INFO - 'TERM': 'linux', 09:58:45 INFO - 'TMOUT': '86400', 09:58:45 INFO - 'USER': 'cltbld', 09:58:45 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892', 09:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:45 INFO - '_': '/tools/buildbot/bin/python'} 09:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:45 INFO - Downloading/unpacking blobuploader==1.2.4 09:58:45 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 09:58:45 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 09:58:45 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 09:58:45 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 09:58:45 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 09:58:45 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 09:58:47 INFO - Downloading blobuploader-1.2.4.tar.gz 09:58:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:58:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:58:47 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 09:58:47 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 09:58:47 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 09:58:47 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 09:58:47 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 09:58:47 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 09:58:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:58:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:58:47 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 09:58:47 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 09:58:47 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 09:58:47 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 09:58:47 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 09:58:47 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 09:58:47 INFO - Downloading docopt-0.6.1.tar.gz 09:58:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:58:48 INFO - Installing collected packages: blobuploader, requests, docopt 09:58:48 INFO - Running setup.py install for blobuploader 09:58:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:58:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:58:48 INFO - Running setup.py install for requests 09:58:48 INFO - Running setup.py install for docopt 09:58:48 INFO - Successfully installed blobuploader requests docopt 09:58:48 INFO - Cleaning up... 09:58:48 INFO - Return code: 0 09:58:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:48 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 0x7fb23497df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fa0b0>, '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 0x20fafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20fb440>, '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': '20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892', '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 09:58:48 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 09:58:48 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 09:58:48 INFO - Using env: {'DISPLAY': ':0', 09:58:48 INFO - 'HOME': '/home/cltbld', 09:58:48 INFO - 'LANG': 'en_US.UTF-8', 09:58:48 INFO - 'LANGUAGE': 'en_US:en', 09:58:48 INFO - 'LOGNAME': 'cltbld', 09:58:48 INFO - 'MAIL': '/var/mail/cltbld', 09:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:48 INFO - 'MOZ_NO_REMOTE': '1', 09:58:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:48 INFO - 'NO_EM_RESTART': '1', 09:58:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:48 INFO - 'PWD': '/builds/slave/test', 09:58:48 INFO - 'SHELL': '/bin/bash', 09:58:48 INFO - 'SHLVL': '1', 09:58:48 INFO - 'TERM': 'linux', 09:58:48 INFO - 'TMOUT': '86400', 09:58:48 INFO - 'USER': 'cltbld', 09:58:48 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892', 09:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:48 INFO - '_': '/tools/buildbot/bin/python'} 09:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:48 INFO - Running setup.py (path:/tmp/pip-n7iB1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:48 INFO - Running setup.py (path:/tmp/pip-rCRGHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:48 INFO - Running setup.py (path:/tmp/pip-8QUYJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:49 INFO - Running setup.py (path:/tmp/pip-JNfmXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:49 INFO - Running setup.py (path:/tmp/pip-4B3w0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:49 INFO - Running setup.py (path:/tmp/pip-QieuDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:49 INFO - Running setup.py (path:/tmp/pip-oHXOf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:49 INFO - Running setup.py (path:/tmp/pip-feDSk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:49 INFO - Running setup.py (path:/tmp/pip-UIdi7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:49 INFO - Running setup.py (path:/tmp/pip-2nMLpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:49 INFO - Running setup.py (path:/tmp/pip-5oUdXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:49 INFO - Running setup.py (path:/tmp/pip-O4J_2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:49 INFO - Running setup.py (path:/tmp/pip-gOM5xN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:49 INFO - Running setup.py (path:/tmp/pip-8vqocZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:49 INFO - Running setup.py (path:/tmp/pip-5sCP_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:49 INFO - Running setup.py (path:/tmp/pip-Bpp0TT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:50 INFO - Running setup.py (path:/tmp/pip-bllauZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:58:50 INFO - Running setup.py install for manifestparser 09:58:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Running setup.py install for mozcrash 09:58:50 INFO - Running setup.py install for mozdebug 09:58:50 INFO - Running setup.py install for mozdevice 09:58:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Running setup.py install for mozfile 09:58:50 INFO - Running setup.py install for mozhttpd 09:58:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Running setup.py install for mozinfo 09:58:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Running setup.py install for mozInstall 09:58:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Running setup.py install for mozleak 09:58:50 INFO - Running setup.py install for mozlog 09:58:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:58:51 INFO - Running setup.py install for moznetwork 09:58:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:58:51 INFO - Running setup.py install for mozprocess 09:58:51 INFO - Running setup.py install for mozprofile 09:58:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:58:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:58:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:58:51 INFO - Running setup.py install for mozrunner 09:58:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:58:51 INFO - Running setup.py install for mozscreenshot 09:58:51 INFO - Running setup.py install for moztest 09:58:51 INFO - Running setup.py install for mozversion 09:58:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:58:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:58:51 INFO - Cleaning up... 09:58:51 INFO - Return code: 0 09:58:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:51 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 0x7fb23497df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fa0b0>, '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 0x20fafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20fb440>, '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': '20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892', '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 09:58:51 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 09:58:51 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 09:58:51 INFO - Using env: {'DISPLAY': ':0', 09:58:51 INFO - 'HOME': '/home/cltbld', 09:58:51 INFO - 'LANG': 'en_US.UTF-8', 09:58:51 INFO - 'LANGUAGE': 'en_US:en', 09:58:51 INFO - 'LOGNAME': 'cltbld', 09:58:51 INFO - 'MAIL': '/var/mail/cltbld', 09:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:51 INFO - 'MOZ_NO_REMOTE': '1', 09:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:51 INFO - 'NO_EM_RESTART': '1', 09:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:51 INFO - 'PWD': '/builds/slave/test', 09:58:51 INFO - 'SHELL': '/bin/bash', 09:58:51 INFO - 'SHLVL': '1', 09:58:51 INFO - 'TERM': 'linux', 09:58:51 INFO - 'TMOUT': '86400', 09:58:51 INFO - 'USER': 'cltbld', 09:58:51 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892', 09:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:51 INFO - '_': '/tools/buildbot/bin/python'} 09:58:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:52 INFO - Running setup.py (path:/tmp/pip-NRDa_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:52 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)) 09:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:52 INFO - Running setup.py (path:/tmp/pip-6DmZM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:52 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)) 09:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:52 INFO - Running setup.py (path:/tmp/pip-nq_ILQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:52 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)) 09:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:52 INFO - Running setup.py (path:/tmp/pip-f2Jwwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:52 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)) 09:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:52 INFO - Running setup.py (path:/tmp/pip-loBo3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:52 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)) 09:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:52 INFO - Running setup.py (path:/tmp/pip-HoKfpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:52 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)) 09:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:52 INFO - Running setup.py (path:/tmp/pip-05_4g9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:52 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)) 09:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:52 INFO - Running setup.py (path:/tmp/pip-LpoAVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:52 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)) 09:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:52 INFO - Running setup.py (path:/tmp/pip-SdOMIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:52 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)) 09:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:52 INFO - Running setup.py (path:/tmp/pip-B33Gr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:52 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)) 09:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:52 INFO - Running setup.py (path:/tmp/pip-BG6gh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:52 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)) 09:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:52 INFO - Running setup.py (path:/tmp/pip-QrLdcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:52 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)) 09:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:52 INFO - Running setup.py (path:/tmp/pip-6dAN3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:53 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)) 09:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:53 INFO - Running setup.py (path:/tmp/pip-gBqRym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:53 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)) 09:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:53 INFO - Running setup.py (path:/tmp/pip-0z917i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:53 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)) 09:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:53 INFO - Running setup.py (path:/tmp/pip-0SmdEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:53 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)) 09:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:53 INFO - Running setup.py (path:/tmp/pip-Q77lWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:53 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)) 09:58:53 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)) 09:58:53 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)) 09:58:53 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)) 09:58:53 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)) 09:58:53 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)) 09:58:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58:53 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 09:58:53 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 09:58:53 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 09:58:53 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 09:58:53 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 09:58:53 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 09:58:54 INFO - Downloading blessings-1.5.1.tar.gz 09:58:54 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 09:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:58:55 INFO - Installing collected packages: blessings 09:58:55 INFO - Running setup.py install for blessings 09:58:55 INFO - Successfully installed blessings 09:58:55 INFO - Cleaning up... 09:58:55 INFO - Return code: 0 09:58:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:58:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:55 INFO - Reading from file tmpfile_stdout 09:58:55 INFO - Current package versions: 09:58:55 INFO - argparse == 1.2.1 09:58:55 INFO - blessings == 1.5.1 09:58:55 INFO - blobuploader == 1.2.4 09:58:55 INFO - docopt == 0.6.1 09:58:55 INFO - manifestparser == 1.1 09:58:55 INFO - mozInstall == 1.12 09:58:55 INFO - mozcrash == 0.16 09:58:55 INFO - mozdebug == 0.1 09:58:55 INFO - mozdevice == 0.47 09:58:55 INFO - mozfile == 1.2 09:58:55 INFO - mozhttpd == 0.7 09:58:55 INFO - mozinfo == 0.9 09:58:55 INFO - mozleak == 0.1 09:58:55 INFO - mozlog == 3.1 09:58:55 INFO - moznetwork == 0.27 09:58:55 INFO - mozprocess == 0.22 09:58:55 INFO - mozprofile == 0.27 09:58:55 INFO - mozrunner == 6.11 09:58:55 INFO - mozscreenshot == 0.1 09:58:55 INFO - mozsystemmonitor == 0.0 09:58:55 INFO - moztest == 0.7 09:58:55 INFO - mozversion == 1.4 09:58:55 INFO - psutil == 3.1.1 09:58:55 INFO - requests == 1.2.3 09:58:55 INFO - wsgiref == 0.1.2 09:58:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:55 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 0x7fb23497df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fa0b0>, '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 0x20fafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20fb440>, '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': '20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892', '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 09:58:55 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 09:58:55 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 09:58:55 INFO - Using env: {'DISPLAY': ':0', 09:58:55 INFO - 'HOME': '/home/cltbld', 09:58:55 INFO - 'LANG': 'en_US.UTF-8', 09:58:55 INFO - 'LANGUAGE': 'en_US:en', 09:58:55 INFO - 'LOGNAME': 'cltbld', 09:58:55 INFO - 'MAIL': '/var/mail/cltbld', 09:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:55 INFO - 'MOZ_NO_REMOTE': '1', 09:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:55 INFO - 'NO_EM_RESTART': '1', 09:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:55 INFO - 'PWD': '/builds/slave/test', 09:58:55 INFO - 'SHELL': '/bin/bash', 09:58:55 INFO - 'SHLVL': '1', 09:58:55 INFO - 'TERM': 'linux', 09:58:55 INFO - 'TMOUT': '86400', 09:58:55 INFO - 'USER': 'cltbld', 09:58:55 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892', 09:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:55 INFO - '_': '/tools/buildbot/bin/python'} 09:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:55 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)) 09:58:55 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)) 09:58:55 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)) 09:58:55 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)) 09:58:55 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)) 09:58:55 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)) 09:58:55 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)) 09:58:55 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)) 09:58:55 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)) 09:58:55 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)) 09:58:55 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)) 09:58:55 INFO - Cleaning up... 09:58:55 INFO - Return code: 0 09:58:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:55 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 0x7fb23497df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fa0b0>, '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 0x20fafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20fb440>, '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': '20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892', '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 09:58:55 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 09:58:55 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 09:58:55 INFO - Using env: {'DISPLAY': ':0', 09:58:55 INFO - 'HOME': '/home/cltbld', 09:58:55 INFO - 'LANG': 'en_US.UTF-8', 09:58:55 INFO - 'LANGUAGE': 'en_US:en', 09:58:55 INFO - 'LOGNAME': 'cltbld', 09:58:55 INFO - 'MAIL': '/var/mail/cltbld', 09:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:55 INFO - 'MOZ_NO_REMOTE': '1', 09:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:55 INFO - 'NO_EM_RESTART': '1', 09:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:55 INFO - 'PWD': '/builds/slave/test', 09:58:55 INFO - 'SHELL': '/bin/bash', 09:58:55 INFO - 'SHLVL': '1', 09:58:55 INFO - 'TERM': 'linux', 09:58:55 INFO - 'TMOUT': '86400', 09:58:55 INFO - 'USER': 'cltbld', 09:58:55 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892', 09:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:55 INFO - '_': '/tools/buildbot/bin/python'} 09:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:55 INFO - Downloading/unpacking jsonschema 09:58:55 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 09:58:55 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 09:58:55 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 09:58:55 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 09:58:55 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 09:58:55 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 09:58:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:58:57 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 09:58:57 INFO - Downloading/unpacking functools32 (from jsonschema) 09:58:57 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 09:58:57 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 09:58:57 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 09:58:57 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 09:58:57 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 09:58:57 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 09:58:57 INFO - Downloading functools32-3.2.3-2.tar.gz 09:58:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:58:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:58:57 INFO - warning: no files found matching '*.txt' 09:58:57 INFO - no previously-included directories found matching 'build' 09:58:57 INFO - no previously-included directories found matching 'dist' 09:58:57 INFO - no previously-included directories found matching '.git*' 09:58:57 INFO - Installing collected packages: jsonschema, functools32 09:58:57 INFO - Running setup.py install for functools32 09:58:57 INFO - warning: no files found matching '*.txt' 09:58:57 INFO - no previously-included directories found matching 'build' 09:58:57 INFO - no previously-included directories found matching 'dist' 09:58:57 INFO - no previously-included directories found matching '.git*' 09:58:57 INFO - Successfully installed jsonschema functools32 09:58:57 INFO - Cleaning up... 09:58:58 INFO - Return code: 0 09:58:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb23497df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fa0b0>, '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 0x20fafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20fb440>, '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': '20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892', '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 09:58:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:58:58 INFO - Using env: {'DISPLAY': ':0', 09:58:58 INFO - 'HOME': '/home/cltbld', 09:58:58 INFO - 'LANG': 'en_US.UTF-8', 09:58:58 INFO - 'LANGUAGE': 'en_US:en', 09:58:58 INFO - 'LOGNAME': 'cltbld', 09:58:58 INFO - 'MAIL': '/var/mail/cltbld', 09:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:58 INFO - 'MOZ_NO_REMOTE': '1', 09:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:58 INFO - 'NO_EM_RESTART': '1', 09:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:58 INFO - 'PWD': '/builds/slave/test', 09:58:58 INFO - 'SHELL': '/bin/bash', 09:58:58 INFO - 'SHLVL': '1', 09:58:58 INFO - 'TERM': 'linux', 09:58:58 INFO - 'TMOUT': '86400', 09:58:58 INFO - 'USER': 'cltbld', 09:58:58 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892', 09:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:58 INFO - '_': '/tools/buildbot/bin/python'} 09:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:58 INFO - Downloading/unpacking flake8 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:58:59 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 09:58:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:59:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:59:00 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 09:59:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:59: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 09:59: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 09:59: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 09:59: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 09:59: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 09:59: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 09:59:00 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 09:59:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:59: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 09:59: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 09:59: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 09:59: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 09:59: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 09:59: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 09:59:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:59:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:59:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:59:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:59:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:59:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:59:00 INFO - no previously-included directories found matching 'docs/_build' 09:59:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:59:00 INFO - Running setup.py install for pep8 09:59:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:59:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:59:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:59:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:59:00 INFO - no previously-included directories found matching 'docs/_build' 09:59:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:59:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:59:00 INFO - Cleaning up... 09:59:00 INFO - Return code: 0 09:59:00 INFO - Running post-action listener: _resource_record_post_action 09:59:00 INFO - Running post-action listener: _start_resource_monitoring 09:59:00 INFO - Starting resource monitoring. 09:59:00 INFO - ##### 09:59:00 INFO - ##### Running install step. 09:59:00 INFO - ##### 09:59:00 INFO - Running pre-action listener: _resource_record_pre_action 09:59:00 INFO - Running main action method: install 09:59:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:59:01 INFO - Reading from file tmpfile_stdout 09:59:01 INFO - Detecting whether we're running mozinstall >=1.0... 09:59:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:59:01 INFO - Reading from file tmpfile_stdout 09:59:01 INFO - Output received: 09:59:01 INFO - Usage: mozinstall [options] installer 09:59:01 INFO - Options: 09:59:01 INFO - -h, --help show this help message and exit 09:59:01 INFO - -d DEST, --destination=DEST 09:59:01 INFO - Directory to install application into. [default: 09:59:01 INFO - "/builds/slave/test"] 09:59:01 INFO - --app=APP Application being installed. [default: firefox] 09:59:01 INFO - mkdir: /builds/slave/test/build/application 09:59:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:59:16 INFO - Reading from file tmpfile_stdout 09:59:16 INFO - Output received: 09:59:16 INFO - /builds/slave/test/build/application/firefox/firefox 09:59:16 INFO - Running post-action listener: _resource_record_post_action 09:59:16 INFO - ##### 09:59:16 INFO - ##### Running run-tests step. 09:59:16 INFO - ##### 09:59:16 INFO - Running pre-action listener: _resource_record_pre_action 09:59:16 INFO - Running main action method: run_tests 09:59:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:59:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:59:16 INFO - Python 2.7.3 09:59:16 INFO - Return code: 0 09:59:16 INFO - grabbing minidump binary from tooltool 09:59: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')]} 09:59: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 0x20fa0b0>, '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 0x20fafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20fb440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:59: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 09:59: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 09:59:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:59:16 INFO - Return code: 0 09:59:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:59:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:59:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:59:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:59:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:59:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:59:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:59:17 INFO - Return code: 0 09:59: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/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost'] in /builds/slave/test/build 09:59: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/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost 09:59:17 INFO - Using env: {'DISPLAY': ':0', 09:59:17 INFO - 'HOME': '/home/cltbld', 09:59:17 INFO - 'LANG': 'en_US.UTF-8', 09:59:17 INFO - 'LANGUAGE': 'en_US:en', 09:59:17 INFO - 'LOGNAME': 'cltbld', 09:59:17 INFO - 'MAIL': '/var/mail/cltbld', 09:59:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:59:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:17 INFO - 'MOZ_NO_REMOTE': '1', 09:59:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:59:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:17 INFO - 'NO_EM_RESTART': '1', 09:59:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:17 INFO - 'PWD': '/builds/slave/test', 09:59:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:59:17 INFO - 'SHELL': '/bin/bash', 09:59:17 INFO - 'SHLVL': '1', 09:59:17 INFO - 'TERM': 'linux', 09:59:17 INFO - 'TMOUT': '86400', 09:59:17 INFO - 'USER': 'cltbld', 09:59:17 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892', 09:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:17 INFO - '_': '/tools/buildbot/bin/python'} 09:59: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/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost'] with output_timeout 3600 09:59:17 INFO - mozversion INFO | application_buildid: 20151210085453 09:59:17 INFO - mozversion INFO | application_changeset: bfa8b0451cfcc7d2825c9147e78c48657c9cd1c0 09:59:17 INFO - mozversion INFO | application_display_name: Nightly 09:59:17 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:59:17 INFO - mozversion INFO | application_name: Firefox 09:59:17 INFO - mozversion INFO | application_remotingname: firefox 09:59:17 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:59:17 INFO - mozversion INFO | application_vendor: Mozilla 09:59:17 INFO - mozversion INFO | application_version: 45.0a1 09:59:17 INFO - mozversion INFO | platform_buildid: 20151210085453 09:59:17 INFO - mozversion INFO | platform_changeset: bfa8b0451cfcc7d2825c9147e78c48657c9cd1c0 09:59:17 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:59:17 INFO - mozversion INFO | platform_version: 45.0a1 09:59:17 INFO - 2015-12-10 09:59:17,280 DEBUG : using testdate: 1449770357 09:59:17 INFO - 2015-12-10 09:59:17,280 DEBUG : actual date: 1449770357 09:59:17 INFO - 2015-12-10 09:59:17,289 INFO : starting webserver on 'localhost:33795' 09:59:17 INFO - 2015-12-10 09:59:17,290 INFO : Starting test suite talos-linux64-ix-065.e 09:59:17 INFO - 2015-12-10 09:59:17,290 INFO : Starting test dromaeo_css 09:59:17 INFO - 2015-12-10 09:59:17,290 DEBUG : operating with platform_type : linux_ 09:59:17 INFO - 2015-12-10 09:59:17,291 INFO : Initialising browser for dromaeo_css test... 09:59:17 INFO - 2015-12-10 09:59:17,305 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0_wtLn/profile http://localhost:33795/getInfo.html 09:59:22 INFO - 2015-12-10 09:59:22,505 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:59:22 INFO - 2015-12-10 09:59:22,505 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:59:22 INFO - 2015-12-10 09:59:22,505 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:59:22 INFO - 2015-12-10 09:59:22,506 DEBUG : BROWSER_OUTPUT: __metrics 09:59:22 INFO - 2015-12-10 09:59:22,634 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] 09:59:23 INFO - 2015-12-10 09:59:23,599 INFO : Browser initialized. 09:59:23 INFO - 2015-12-10 09:59:23,600 INFO : Running cycle 1/1 for dromaeo_css test... 09:59:23 INFO - 2015-12-10 09:59:23,600 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0_wtLn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:59:35 INFO - 2015-12-10 09:59:35,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 142602240 09:59:35 INFO - 2015-12-10 09:59:35,589 DEBUG : BROWSER_OUTPUT: 10:00:25 INFO - 2015-12-10 10:00:25,228 DEBUG : BROWSER_OUTPUT: 1449770425227 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] 10:02:36 INFO - 2015-12-10 10:02:36,912 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33795/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33795/tests/dromaeo/cssquery-ext.html) 10:02:38 INFO - 2015-12-10 10:02:38,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 146997248 10:02:38 INFO - 2015-12-10 10:02:38,078 DEBUG : BROWSER_OUTPUT: 10:05:40 INFO - 2015-12-10 10:05:40,131 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33795/tests/dromaeo/cssquery-ext.html (next: http://localhost:33795/tests/dromaeo/cssquery-jquery.html) 10:05:40 INFO - 2015-12-10 10:05:40,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 144773120 10:05:40 INFO - 2015-12-10 10:05:40,725 DEBUG : BROWSER_OUTPUT: 10:08:42 INFO - 2015-12-10 10:08:42,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33795/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33795/tests/dromaeo/cssquery-mootools.html) 10:08:43 INFO - 2015-12-10 10:08:43,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 144433152 10:08:43 INFO - 2015-12-10 10:08:43,121 DEBUG : BROWSER_OUTPUT: 10:11:44 INFO - 2015-12-10 10:11:44,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33795/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33795/tests/dromaeo/cssquery-prototype.html) 10:11:45 INFO - 2015-12-10 10:11:45,504 DEBUG : BROWSER_OUTPUT: RSS: Main: 144117760 10:11:45 INFO - 2015-12-10 10:11:45,504 DEBUG : BROWSER_OUTPUT: 10:14:48 INFO - 2015-12-10 10:14:48,213 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33795/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33795/tests/dromaeo/cssquery-yui.html) 10:14:48 INFO - 2015-12-10 10:14:48,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 143687680 10:14:48 INFO - 2015-12-10 10:14:48,840 DEBUG : BROWSER_OUTPUT: 10:17:51 INFO - 2015-12-10 10:17:51,165 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33795/tests/dromaeo/cssquery-yui.html (next: http://localhost:33795/tests/dromaeo/cssquery-dojo.html) 10:17:51 INFO - 2015-12-10 10:17:51,415 DEBUG : BROWSER_OUTPUT: RSS: Main: 146853888 10:17:51 INFO - 2015-12-10 10:17:51,415 DEBUG : BROWSER_OUTPUT: 10:17:51 INFO - 2015-12-10 10:17:51,415 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:17:51 INFO - 2015-12-10 10:17:51,415 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:17:51 INFO - 2015-12-10 10:17:51,415 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:17:51 INFO - 2015-12-10 10:17:51,416 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:17:51 INFO - 2015-12-10 10:17:51,416 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2621.895124195032;2669.4260733942197;2697.635819164412;2710.186943916826;2713;4514.954850451494;4687.437507499097;4698.318743782153;4731.030138821542;4753.572178503934;4651.186042442576;4652.720836749797;4668.906621867561;4708.7645617719145;4868.926966095502;4280.229558679436;4345.674074444413;4404.141192467454;4428.0701052778795;4483.3723278741;4302.204092242945;4317.76252306123;4335.609795118438;4408.42690450241;4438.911221775563;4214.91570168598;4238.5761423857675;4239.703220774547;4290.4636920384955;4365.454318210223;4343.2182207202695;4389.144116897206;4402.141582391435;4402.449693788277;4427.070315233805;4376;4395.516493185747;4405.933910991338;4409.272470042439;4444.533324000998;4445.222086134913;4547.977260113711;4598.379218805452;4686.484486706459;4729.905401891977;4992.775325110379;5039.067772462106;5050.772715227824;5081.390233172043;5115.258287548322;5085.923711144335;5087.669301495428;5087.872803179913;5090.389153301628;5099.59203263738;4503.932441013388;4607.0785842831565;4608.055348653518;4613.469451013177;4654.86035418938;5125.384953805567;5145.76844042019;5164.793408263702;5185.766640501187;5222.2427747976335;4944.258361245842;4945.554900059012;4954.108260513142;4954.628402869799;4991.900161996739;4743.691660042086;4857.53853383928;4861.149298872683;4983.352164218701;5045.016221836707;4993.27597498368;5015.4733752956145;5022.347094877642;5030.195168772979;5070.391553013588;4991.425986011583;4997.275395067695;5000.449950505442;5008.974955125274;5072.9746351268;4039.3940908863906;4121.814518346681;4130.669546436278;4131.091159944807;4134.669226461876;3613.1689711366007;3643.617420170844;3676.6139555346303;3679.3193259247123;3699.3711069117776;4299.806508707115;4321.157374311979;4342.435483387139;4370.978145109254;4415.492218394926;4809.038192361541;4860.3681521401995;4908.509149085063;5063.696178229245;5067.5439210470495;4347.847825326098;4363.040131171138;4365.585269399402;4369.038811461473;4422.646188304928;4470.932936005963;4481.910361792746;4489.393931819228;4493.4607847057905;4538.115067561794;4585.885352866138;4702.200625893538;4715.481297057252;4804.054357985022;4824.372831532019;4956.752162391938;4969.751512424436;4975.10448119342;4979;4980.676256043345;4677.859664210079;4715.81136754526;4722.763861806827;4733.928991065206;4760.976195119002;4773.11697335994;4874.731889746098;4910.189818679878;4943.382077240345;4987.700737955734;4963.429205641398;5005.899882002413;5014.924776128434;5015.749212539431;5030.597552195889;4727.3854398927915;4839.975800120977;4849.442314133919;4852.126617208936;4890.242012487928;4746.8101275948575;4822.7829747660735;4823.469418363907;4830.396200474941;4862.41651001882;4708.5997690195345;4728.929066064081;4734.810607575796;4803.135435621622;4804.42346918372;4697.8355757548325;4813.807447702053;4896.804127834846;4905.656604037683;4938.950610493849;4713.198756211521;4767.904641907212;4771.475137734916;4790.568848803624;4832.124885693007 10:17:51 INFO - 2015-12-10 10:17:51,417 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.3740791609439;569.2628046679547;576.5848589015908;583.2417856786177;585.3385674188166;35692.2861542769;36497;36542.26915461689;36560;36663.816680916556;40324.39513407301;40730.38904416429;40880;40883.386749198784;40906.59093409065;7903.604819759018;8007.799805004893;8080.636371363303;8084.231997960184;8089.271965523102;7910.7626771196665;7961.084475285329;7969.322607578363;7982.640781164861;7991.041075071;7909;7974.202579742037;7997.200279971986;8014.358851291911;8023.4383593148505;7833.804154896116;7908.762737117896;7909.525428474252;7913.208679132098;7914.050313962304;7872;7974.0431148262;7994.6002699864775;8017.238362355567;8017.839643207161;37113.25773484515;37475.437868431996;37693;37705.43441848347;37715;2693.2728163395773;2731.4537092581563;3197.1563181071347;3219.5331676906953;3245.075153581218;28029;28054.859725701444;28305.716942830513;28368.290792730346;28369.432611347864;3367.5285460035616;3480.1473638958364;3507;3526.294741051774;3635.800030998294;217870;218424;219061;219440;219775.9999999984;52219.47780522146;56148.43851561432;56507.71746141325;56598.71700641471;56643;45181.54818451839;59885;60163.699181504686;60186.39813601896;60190.69904650449;13327.933360333136;13599.796003059764;13655.590332290047;13688.65778355549;13807.378667959965;9585.616575336908;9617.855732164024;9635.084666956627;9675;9703.175230105378;18958.241670333307;19380.515487112654;19630.116644751022;19640.901795490932;19753.802461975483;7539.208383119803;7820;7851.254130857559;7924.286814186751;7937.880931786028;769.1923480345615;772.420684486635;814.2956342763467;820.1388542030844;845.3026253341018;24395.51208975846;24653;24699.259022229362;24723;24798.504029919663;908.7591788176138;956.6508224498008;986.2061040862031;1011.8836333821557;1056.2975621211963;13224.942004639606;13297;15470;15485.690286194213;16058.277377517807;311630;316883;319311;319555;320518;48842.755786221554;49204.50795492071;49691.50308496941;49707.751461242464;49712;1104.5581767293147;1202.5790973159324;1203.3983008495752;1205.0600531585378;1224.5224362498632;26759;26836.313480124885;27267.863660682364;27297.181084567495;27376.45247095007;39122.217555649295;39199.2160156801;39681;39750.60249397469;39750.60249397469;249212;250785;251831;252216;252453;28438.715612843607;40575;41962.37056444217;42415.5758442424;42534;38248.235035299695;38318;39329.803350984206;39337;39359.80320098381;32854.342913141125;32869;33440;33706.79785420381;33901.15247118842;33078.669213307556;33696;33803.66196338005;33853.66146338505;33897;32930;32987.17532061718;33260.33479330448;33329.166770830925;33393.165170870925;28046.43907121887;29238.853805730836;30116.79532818663;30253.697463025088;30397;24450.266492005267;24914.252572422858;25282.87358563269;25398;25510.489790204465 10:17:51 INFO - 2015-12-10 10:17:51,418 DEBUG : BROWSER_OUTPUT: |2;jquery.html;343.7456282351059;343.82121296925584;346.32812344052536;347.21529343683267;347.32792047388307;15094.094354338733;15539.766903496457;16244;16865.40971066013;17500.824991750094;15293.388264469408;15561.610959726013;15587.220638968063;15624.609384765386;15895.52313430596;4449.243628583141;4572.314152877078;4585.99108196198;4587.036722288323;4590.173768721629;4620.19146649335;4623.1678297906365;4627.629789616823;4635.629149668035;4640.60554852838;4581.518940511249;4806.903861922777;5053.898922021557;5208.687478751268;5239.266502689627;5023.572996295319;5059.544640982329;5065.468125846806;5106.591472682177;5233.528982391603;5290.365156181283;5298.761555730001;5323.361196656388;5324.307839980816;5331.333583302087;11254.381009044499;11453.37006464644;14694.706105877929;17725.911370443195;17875.553111172194;1738.5914310137107;1746.3276638494144;1770.2211027148142;1771.2206629083162;1811.9547011324692;8667.956660216658;8689.000764911989;8727.781805454915;8732.388732788708;9149.359544831865;1678.681050600382;1710.144927536232;1721.870859685516;1729.3428497171121;1730.4981555348934;33803.32393352119;35817.28365432677;47932.52067479315;48087.75956120197;48374.75812620914;10009.249306302056;10047;10107.191424686007;10152.644657436955;10178.033086856736;12545.310007949467;12647.683807904692;12654.683632909067;12658.493660253487;12754;7133.252353173402;8384.706535271236;8450.183210609748;8561.957190214134;8570.74287771368;6867.450603951772;6920.4809639277255;7043.647817609099;7080.327368899946;7130.750423735248;7503.212162722835;7546.094468663686;7559.395248380117;7574.318311351894;7611.65747541362;2984.9701502984694;2996.310848504856;3060.709232622897;3068.110248028047;3081.3529158876886;360.5223079419727;379.0523690773067;380.28506407953427;383.6892117384927;422.2968757019528;10211.846822297672;10429.895701043044;10651.573937042587;10659.573617055386;10679.305845120043;392.7074329624391;413.0705911698678;414.9232392007488;424.1051381584854;428.6570743405263;5525.972370138124;5737.770489180386;5793.073108302651;5825.213596164548;5838.7080645967535;516444;523518;523557;524127;529887;71939.28060719326;75537.24462755302;76025;76349;76544.61727691325;445.612317283965;452.57231915839213;453.62802501948084;453.6733551842668;453.90921815637006;9753.31726779147;9885.85171222418;9927.453990030617;9945.552450139905;10121;30686.846565767028;33296;34611.653883460844;34870.30259394849;35885.1028724284;38230;41323.793381034106;41912.790436047624;42070.36894446647;42201.15597687968;8510.61702223389;8758.343124265579;8908.10918908104;8941.508217047865;8945.686900958435;8855.690050848189;9118.361714679908;9171.908280917105;9501.334906556474;16472;8671.783205419915;8852.867206992029;8985.415947963624;9080.818383632422;9089.77275568116;8974.14745599167;9275.536223188948;9367.391119577205;9505.382150160218;9665.758356041155;9361.485118318558;9364.625414983324;9859.950700246452;10099.192064634664;10109.696709098738;12936.417861196456;13430.328483575588;13459.259740714355;14003.50987715425;14049.648758781112;14157.646058848612;14186.716265674835;14236.928815355857;14489.275536223358;14492.492762753252 10:17:51 INFO - 2015-12-10 10:17:51,418 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1477.0177831741892;1601.1433882872661;1666.9583260418492;1680.4286542575521;1722.9310827566899;5801.53587712983;6118.785842495514;6557.73769049238;7010.7195712171515;7057.2942705729465;6414.935850641492;6561.343865613437;6569.572977756443;6595.967020164892;6609.735610575583;2042.0708577597159;2068.95862082759;2069.368842503036;2071.523549583589;2072.1607748861734;2034.9084291206857;2057.434205593459;2063.226290141197;2087.634663933813;2087.645100332947;2003.509140260638;2027.8276346510565;2057.5987682401937;2060.556980249246;2067.3177851309033;2069.9172033118657;2090.1325949730917;2090.5087304483436;2108.399106254725;2109.9261525846673;2052.148358431264;2057.989710051455;2091.884946327951;2092.3199960013058;2098.4963608733947;6845.452363810883;6914.481413893978;6925;6934.445244380488;6941.444684425234;4042;4102.200070986159;4127.195196936598;4141.64795992341;4142.875713728593;2672.7327267273313;2684.7315268473194;2721.18364490652;2740.753332200092;2754.1737478756295;849.9362547808939;864.1358641358642;871.3769654696922;887.7691800132012;914.4741773480209;8994;9044.3668943174;9135.40619859707;9170.86243706345;9175.862362064574;3657.579378371468;3699.519062521909;3721.7580857244193;3761.4921985531605;3779.149691319431;8034.83930321402;8043.919560804434;8047.114817370085;8063.516189028677;8064.395170362246;4079.326911059701;4089.468369112056;4092.652124569445;4107.856225032169;4120.196561670506;3307.6526964668365;3404.8808291710166;3709.9443508347395;3731.5149030625844;3768.660820526111;3450.275442157175;3479.8956031319103;3491.5635545556806;3497.2306092659574;3500.544929159193;1090.465671820802;1098.4068602954476;1100.2628239079836;1101.7025403141106;1106.3804269608884;1146.157574182975;1156.0982433701727;1179.0096319092004;1183.597576823884;1204.1992075270023;6708.798736037927;6732.158480189976;6740.9325906740305;6748;6761.729530818712;996.7209181429066;1002.5939494504737;1012.3875055591409;1015.2892974917587;1018.974525636865;5009.173486374781;5098.97450512745;5112.514311140436;5115.8721031973755;5146.279520867081;8030.638621262057;8204.753857384288;8217.465864718773;8548.74353769388;8552.828943421096;8347.332213422911;8351.24838764514;8369.49783013009;8383.958080209683;8390.454620449773;6547.377999090078;6563.934360656428;6596.60420374779;6671;6726.125603671491;6433.067205255305;6436.517261205335;6458.321876203119;6471.611703297817;6488.383603557654;7331.230220826949;7574.469787115069;7590;7598.126215485069;7723.497972631761;7324.63376831167;7535.660895259617;7561.4706970513735;7792.88310675329;7827.060752709711;5935.465808077293;6056.878862422815;6069.514438844793;6086.786962456293;6151.692415379123;6656.400923916871;6694.866102678016;6697.3637504437;6708.295628959084;6731.730730770714;6221.875562488634;6247.437730604267;6268.561200715906;6295.905561416491;6453.515986300952;6071.908921366095;6095.786647467317;6108.602940808833;6110.419510146529;6233.812985610439;6353.936460635335;6386.329435409215;6386.680665966776;6393.840153996187;6408.231012278557;5631.577631677558;5649.887002260014;5650.180723795109;5682.829515114553;5689.402612725769;5901.409859014064;6026;6033.78881739137;6040.1241819934985;6055.939440605537 10:17:51 INFO - 2015-12-10 10:17:51,420 DEBUG : BROWSER_OUTPUT: |4;prototype.html;306.6473555411277;307.7614848492418;318.6415282806842;319.4872230070736;322.072431397575;5473.452654734525;5501.559875209983;5588.30146231721;5619.971900140498;5627.493525582702;5379.704116273603;5487.6158668893095;5487.780488780454;5494.148406996912;5502.5597952163835;4304.053108316165;4325.351197320396;4333.133373325331;4334.739915605058;4357.847475338363;4328.112736888946;4333.176696427684;4339.696221264513;4355.041890784022;4361.760103194323;4102.835886564534;4217.430646862665;4303.117860838536;4316.07204451043;4318.417013703157;4202.222588821078;4208.768517731523;4224.9155016899485;4261.936070958938;4269.444972153631;3706.110533471974;3712.3317802795486;3712.9443058354145;3713.1274150574595;3717.20080182762;5377.435369286247;5380.085385484438;5421.972890135564;5426.891462170774;5436.565074794007;4681.274402467623;4851.296561998491;4866.975665121687;4883.8779030524165;4899.387576552931;5650.406707295757;5826.126081087871;5829.504492118175;5832.533397328203;5838.9124163137585;3965.088029753173;3969.7419667721792;3994.800259986989;4012.7592344459426;4017.015831121394;6057.757689692407;6138.0792881067755;6139.355367686373;6143.78496752616;6150.600210986271;3986.541547722049;4126.256039733604;4126.731762435432;4135.669146468275;4148.589479576958;4181.519125300569;4185.707000509996;4210.6841986851105;4214.220369231702;4223.894402639959;4786.497417771154;4837.250226214872;4848.17581011229;4862.756862156878;4883.560479556857;5808.5062769665055;5853.648781073064;5855.268091488564;5862.413758624103;5870.442307980735;1439.6976634906578;1451.1583281696592;1456.9635759106106;1486.851314868526;1495.1627088830073;983.5770618634056;997.9550920208608;1008.1078245752415;1009.162395211987;1011.1001208924064;4963.726995015237;4965.776540055706;4967.801287948514;4968.254761785689;4981.651284410129;5896.498797602252;5930.11048342752;5978.760849566055;6006.789762358297;6010.278766548042;5004.074246264453;5025.070361982972;5037.546620804072;5042.294078828967;5044.2937988681615;3189.521571764254;3193.3134376109247;3228.9990103068126;3239.627442844056;3250.658680838525;5632.549396048306;5645.2096706461125;5651.180578816049;5660.094384898396;5671.092625179951;6139.140520327158;6150;6152.569320147547;6155.907661385083;6166.784162554289;5617.9719101404235;5638.633488823213;5658.85852853682;5663.263775709132;5674.06377947634;5948.39393363798;6136.5090792737365;6142.04798256271;6157.568970172045;6160.13758073861;6023.578349515492;6035.456808887221;6042.456178943916;6048.123022161674;6053.757849685963;5762.711864406847;5777.826665200051;5785.392533783892;5790.276215473066;5792.478676919098;4121.185562903287;4155.729877557949;4159.854405095807;4192.811323490511;4196.706230563831;5986.102084687158;6143.754249829957;6155.907661385172;6157.199564056644;6158.261008678808;5816.331121921034;5869.148973398918;5897.3807750185615;5902.350741418526;5906.70466476683;5890.175375447527;5895.20414744004;5899.056151015817;5908.734106965111;5919.437653422918;5653.575981801464;5769.105788602773;5771.422857714195;5773.74018169175;5777.04678728022;5885.705714714333;5916.881662366643;5918.73365698536;5942.940570594239;5948.940510595012;5752.395998420106;5760.308762948473;5765.8558536036935;5767.884642307215;5768.94231057684 10:17:51 INFO - 2015-12-10 10:17:51,421 DEBUG : BROWSER_OUTPUT: |5;yui.html;716.1406312425088;718.3893690363192;736.9388081163127;753.1865585168019;776.4681193382534;11852.170348075639;11983.221090629126;12016.7596648067;12066.577669781549;12067.3362965037;11511.42442877857;11797.70505737357;11836.940815295911;11888.048956083514;11945.880541194585;808.8746244332124;814.5397850214639;824.9340052795762;826.2893911236362;831.8585840407145;815.3640160674684;816.6978218059327;823.3948048184579;823.5717426937989;824.2087595907935;859.8151397449548;861.3496809908511;865.1046167216932;867.0202670981781;867.7830542364409;839.4082172068677;843.9324854011664;846.1369403208754;848.1899785704668;852.9360297977645;630.3885231325606;632.2255237334228;633.4077637409038;633.6388258692547;636.8789929913302;11989.520419183222;12089.93955030228;12091.334976576285;12121.39393030345;12130.878691213064;10771.676849694444;10974;11178.832317515162;11220.214584979054;11412.258203216765;9449.291303152222;9525.476098814563;9613.615455381776;9789.167920726746;9834.9508252459;3125.6405513366026;3155.2742869140225;3157.8105313681253;3159.273367125574;3175.1744546417867;40160.59839401598;40719.59280407188;40793.1841363174;40973.1805363894;41181.38227926583;9232.8615070774;9366.438013719198;9516.143547080657;9542.284328675238;9869;15899.694544291244;16027;16051.117188554508;16081.67836643284;16160;5913.231279933581;5996.70016499182;6101.969490152521;6166.81499555014;6175.660338681416;3541.5041894134843;3554.20030493137;3560.893173204808;3579.3736096183065;3583.1937813991644;2860.070477094911;2903.738663520251;2913.810602310843;2914.417116576693;2915.5772412999995;513.7816428018077;518.4116028307823;520.632953767593;521.8695326168458;525.2961032216772;394.59159769638285;404.2400287459557;404.63582775502283;414.9688773342011;423.9872803815891;7023.789286321418;7392.667329970164;7555.09338879338;7665.348445382094;7700.768976930701;501.1080277106756;510.1735188993854;523.5419008367678;526.8472143078541;596.7523477756769;3377.2401209728105;3432.3478539077996;3461.5326930864517;3523.841427135785;3550.094725844893;46552.767236164276;47809.76095119502;47929.76035119802;48031;48383.274250886265;43914;43987.12025759531;44253.336199957026;44483.332750008776;44995.550044499134;40681;41829;42056.57943420588;42064.36903446512;42096.57903420988;6851.794446166623;6994.094030168499;7039.436845052486;7067.929320706933;7118.5017048806085;30470.933517326786;30499.695003049685;30995.380092397576;30996.380072398875;31339.216519587193;36851.447228292134;40199.397009045475;40796.59203407928;40952;40991.795041024605;8459.492430454193;8596.183362580545;8640.524771137396;8684.176322971995;8884.289256859307;9137.543122843697;9147.496887671243;9253.86119208199;9262.72211833646;9416.670416535662;9072.95463522678;9129.90870091317;9235.76910577241;9404.153626173676;9681.806363872824;8705.6953006647;8785.692500762443;9038.63845446201;10723.571057157626;10782.299150555189;9568.378055426376;9943.403395796275;10208.183345332503;10387.428691421743;10392.272540922062;7703.114141873756;7889.84220315579;7912.169222231813;8421.368397370345;8712.651493940424;7693.807654808675;8273.46222495536;8295.211954864279;8306.750797476085;8423 10:17:51 INFO - 2015-12-10 10:17:51,421 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:17:51 INFO - 2015-12-10 10:17:51,421 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:17:51 INFO - 2015-12-10 10:17:51,421 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,326 10:17:51 INFO - 2015-12-10 10:17:51,421 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:17:51 INFO - 2015-12-10 10:17:51,421 DEBUG : BROWSER_OUTPUT: __startTimestamp1449771471414__endTimestamp 10:17:51 INFO - 2015-12-10 10:17:51,422 DEBUG : BROWSER_OUTPUT: 10:17:51 INFO - 2015-12-10 10:17:51,422 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:17:51 INFO - 2015-12-10 10:17:51,422 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:17:51 INFO - 2015-12-10 10:17:51,422 DEBUG : BROWSER_OUTPUT: 10:17:51 INFO - 2015-12-10 10:17:51,422 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4623.87 Median:4729.91 stddev:475.37 (10.1%) stddev-sans-first:450.13 10:17:51 INFO - 2015-12-10 10:17:51,422 DEBUG : BROWSER_OUTPUT: Values: 2621.9 2669.4 2697.6 2710.2 2713.0 4515.0 4687.4 4698.3 4731.0 4753.6 4651.2 4652.7 4668.9 4708.8 4868.9 4280.2 4345.7 4404.1 4428.1 4483.4 4302.2 4317.8 4335.6 4408.4 4438.9 4214.9 4238.6 4239.7 4290.5 4365.5 4343.2 4389.1 4402.1 4402.4 4427.1 4376.0 4395.5 4405.9 4409.3 4444.5 4445.2 4548.0 4598.4 4686.5 4729.9 4992.8 5039.1 5050.8 5081.4 5115.3 5085.9 5087.7 5087.9 5090.4 5099.6 4503.9 4607.1 4608.1 4613.5 4654.9 5125.4 5145.8 5164.8 5185.8 5222.2 4944.3 4945.6 4954.1 4954.6 4991.9 4743.7 4857.5 4861.1 4983.4 5045.0 4993.3 5015.5 5022.3 5030.2 5070.4 4991.4 4997.3 5000.4 5009.0 5073.0 4039.4 4121.8 4130.7 4131.1 4134.7 3613.2 3643.6 3676.6 3679.3 3699.4 4299.8 4321.2 4342.4 4371.0 4415.5 4809.0 4860.4 4908.5 5063.7 5067.5 4347.8 4363.0 4365.6 4369.0 4422.6 4470.9 4481.9 4489.4 4493.5 4538.1 4585.9 4702.2 4715.5 4804.1 4824.4 4956.8 4969.8 4975.1 4979.0 4980.7 4677.9 4715.8 4722.8 4733.9 4761.0 4773.1 4874.7 4910.2 4943.4 4987.7 4963.4 5005.9 5014.9 5015.7 5030.6 4727.4 4840.0 4849.4 4852.1 4890.2 4746.8 4822.8 4823.5 4830.4 4862.4 4708.6 4728.9 4734.8 4803.1 4804.4 4697.8 4813.8 4896.8 4905.7 4939.0 4713.2 4767.9 4771.5 4790.6 4832.1 10:17:51 INFO - 2015-12-10 10:17:51,422 DEBUG : BROWSER_OUTPUT: 10:17:51 INFO - 2015-12-10 10:17:51,422 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42564.84 Median:36551.13 stddev:69488.75 (190.1%) stddev-sans-first:69612.10 10:17:51 INFO - 2015-12-10 10:17:51,423 DEBUG : BROWSER_OUTPUT: Values: 556.4 569.3 576.6 583.2 585.3 35692.3 36497.0 36542.3 36560.0 36663.8 40324.4 40730.4 40880.0 40883.4 40906.6 7903.6 8007.8 8080.6 8084.2 8089.3 7910.8 7961.1 7969.3 7982.6 7991.0 7909.0 7974.2 7997.2 8014.4 8023.4 7833.8 7908.8 7909.5 7913.2 7914.1 7872.0 7974.0 7994.6 8017.2 8017.8 37113.3 37475.4 37693.0 37705.4 37715.0 2693.3 2731.5 3197.2 3219.5 3245.1 28029.0 28054.9 28305.7 28368.3 28369.4 3367.5 3480.1 3507.0 3526.3 3635.8 217870.0 218424.0 219061.0 219440.0 219776.0 52219.5 56148.4 56507.7 56598.7 56643.0 45181.5 59885.0 60163.7 60186.4 60190.7 13327.9 13599.8 13655.6 13688.7 13807.4 9585.6 9617.9 9635.1 9675.0 9703.2 18958.2 19380.5 19630.1 19640.9 19753.8 7539.2 7820.0 7851.3 7924.3 7937.9 769.2 772.4 814.3 820.1 845.3 24395.5 24653.0 24699.3 24723.0 24798.5 908.8 956.7 986.2 1011.9 1056.3 13224.9 13297.0 15470.0 15485.7 16058.3 311630.0 316883.0 319311.0 319555.0 320518.0 48842.8 49204.5 49691.5 49707.8 49712.0 1104.6 1202.6 1203.4 1205.1 1224.5 26759.0 26836.3 27267.9 27297.2 27376.5 39122.2 39199.2 39681.0 39750.6 39750.6 249212.0 250785.0 251831.0 252216.0 252453.0 28438.7 40575.0 41962.4 42415.6 42534.0 38248.2 38318.0 39329.8 39337.0 39359.8 32854.3 32869.0 33440.0 33706.8 33901.2 33078.7 33696.0 33803.7 33853.7 33897.0 32930.0 32987.2 33260.3 33329.2 33393.2 28046.4 29238.9 30116.8 30253.7 30397.0 24450.3 24914.3 25282.9 25398.0 25510.5 10:17:51 INFO - 2015-12-10 10:17:51,423 DEBUG : BROWSER_OUTPUT: 10:17:51 INFO - 2015-12-10 10:17:51,424 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26434.69 Median:453.79 stddev:85512.83 (18844.1%) stddev-sans-first:85730.27 10:17:51 INFO - 2015-12-10 10:17:51,424 DEBUG : BROWSER_OUTPUT: Values: 343.7 343.8 346.3 347.2 347.3 15094.1 15539.8 16244.0 16865.4 17500.8 15293.4 15561.6 15587.2 15624.6 15895.5 4449.2 4572.3 4586.0 4587.0 4590.2 4620.2 4623.2 4627.6 4635.6 4640.6 4581.5 4806.9 5053.9 5208.7 5239.3 5023.6 5059.5 5065.5 5106.6 5233.5 5290.4 5298.8 5323.4 5324.3 5331.3 11254.4 11453.4 14694.7 17725.9 17875.6 1738.6 1746.3 1770.2 1771.2 1812.0 8668.0 8689.0 8727.8 8732.4 9149.4 1678.7 1710.1 1721.9 1729.3 1730.5 33803.3 35817.3 47932.5 48087.8 48374.8 10009.2 10047.0 10107.2 10152.6 10178.0 12545.3 12647.7 12654.7 12658.5 12754.0 7133.3 8384.7 8450.2 8562.0 8570.7 6867.5 6920.5 7043.6 7080.3 7130.8 7503.2 7546.1 7559.4 7574.3 7611.7 2985.0 2996.3 3060.7 3068.1 3081.4 360.5 379.1 380.3 383.7 422.3 10211.8 10429.9 10651.6 10659.6 10679.3 392.7 413.1 414.9 424.1 428.7 5526.0 5737.8 5793.1 5825.2 5838.7 516444.0 523518.0 523557.0 524127.0 529887.0 71939.3 75537.2 76025.0 76349.0 76544.6 445.6 452.6 453.6 453.7 453.9 9753.3 9885.9 9927.5 9945.6 10121.0 30686.8 33296.0 34611.7 34870.3 35885.1 38230.0 41323.8 41912.8 42070.4 42201.2 8510.6 8758.3 8908.1 8941.5 8945.7 8855.7 9118.4 9171.9 9501.3 16472.0 8671.8 8852.9 8985.4 9080.8 9089.8 8974.1 9275.5 9367.4 9505.4 9665.8 9361.5 9364.6 9860.0 10099.2 10109.7 12936.4 13430.3 13459.3 14003.5 14049.6 14157.6 14186.7 14236.9 14489.3 14492.5 10:17:51 INFO - 2015-12-10 10:17:51,424 DEBUG : BROWSER_OUTPUT: 10:17:51 INFO - 2015-12-10 10:17:51,424 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4860.59 Median:6056.41 stddev:2466.81 (40.7%) stddev-sans-first:2460.63 10:17:51 INFO - 2015-12-10 10:17:51,424 DEBUG : BROWSER_OUTPUT: Values: 1477.0 1601.1 1667.0 1680.4 1722.9 5801.5 6118.8 6557.7 7010.7 7057.3 6414.9 6561.3 6569.6 6596.0 6609.7 2042.1 2069.0 2069.4 2071.5 2072.2 2034.9 2057.4 2063.2 2087.6 2087.6 2003.5 2027.8 2057.6 2060.6 2067.3 2069.9 2090.1 2090.5 2108.4 2109.9 2052.1 2058.0 2091.9 2092.3 2098.5 6845.5 6914.5 6925.0 6934.4 6941.4 4042.0 4102.2 4127.2 4141.6 4142.9 2672.7 2684.7 2721.2 2740.8 2754.2 849.9 864.1 871.4 887.8 914.5 8994.0 9044.4 9135.4 9170.9 9175.9 3657.6 3699.5 3721.8 3761.5 3779.1 8034.8 8043.9 8047.1 8063.5 8064.4 4079.3 4089.5 4092.7 4107.9 4120.2 3307.7 3404.9 3709.9 3731.5 3768.7 3450.3 3479.9 3491.6 3497.2 3500.5 1090.5 1098.4 1100.3 1101.7 1106.4 1146.2 1156.1 1179.0 1183.6 1204.2 6708.8 6732.2 6740.9 6748.0 6761.7 996.7 1002.6 1012.4 1015.3 1019.0 5009.2 5099.0 5112.5 5115.9 5146.3 8030.6 8204.8 8217.5 8548.7 8552.8 8347.3 8351.2 8369.5 8384.0 8390.5 6547.4 6563.9 6596.6 6671.0 6726.1 6433.1 6436.5 6458.3 6471.6 6488.4 7331.2 7574.5 7590.0 7598.1 7723.5 7324.6 7535.7 7561.5 7792.9 7827.1 5935.5 6056.9 6069.5 6086.8 6151.7 6656.4 6694.9 6697.4 6708.3 6731.7 6221.9 6247.4 6268.6 6295.9 6453.5 6071.9 6095.8 6108.6 6110.4 6233.8 6353.9 6386.3 6386.7 6393.8 6408.2 5631.6 5649.9 5650.2 5682.8 5689.4 5901.4 6026.0 6033.8 6040.1 6055.9 10:17:51 INFO - 2015-12-10 10:17:51,424 DEBUG : BROWSER_OUTPUT: 10:17:51 INFO - 2015-12-10 10:17:51,424 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4831.12 Median:5487.70 stddev:1434.79 (26.1%) stddev-sans-first:1398.05 10:17:51 INFO - 2015-12-10 10:17:51,426 DEBUG : BROWSER_OUTPUT: Values: 306.6 307.8 318.6 319.5 322.1 5473.5 5501.6 5588.3 5620.0 5627.5 5379.7 5487.6 5487.8 5494.1 5502.6 4304.1 4325.4 4333.1 4334.7 4357.8 4328.1 4333.2 4339.7 4355.0 4361.8 4102.8 4217.4 4303.1 4316.1 4318.4 4202.2 4208.8 4224.9 4261.9 4269.4 3706.1 3712.3 3712.9 3713.1 3717.2 5377.4 5380.1 5422.0 5426.9 5436.6 4681.3 4851.3 4867.0 4883.9 4899.4 5650.4 5826.1 5829.5 5832.5 5838.9 3965.1 3969.7 3994.8 4012.8 4017.0 6057.8 6138.1 6139.4 6143.8 6150.6 3986.5 4126.3 4126.7 4135.7 4148.6 4181.5 4185.7 4210.7 4214.2 4223.9 4786.5 4837.3 4848.2 4862.8 4883.6 5808.5 5853.6 5855.3 5862.4 5870.4 1439.7 1451.2 1457.0 1486.9 1495.2 983.6 998.0 1008.1 1009.2 1011.1 4963.7 4965.8 4967.8 4968.3 4981.7 5896.5 5930.1 5978.8 6006.8 6010.3 5004.1 5025.1 5037.5 5042.3 5044.3 3189.5 3193.3 3229.0 3239.6 3250.7 5632.5 5645.2 5651.2 5660.1 5671.1 6139.1 6150.0 6152.6 6155.9 6166.8 5618.0 5638.6 5658.9 5663.3 5674.1 5948.4 6136.5 6142.0 6157.6 6160.1 6023.6 6035.5 6042.5 6048.1 6053.8 5762.7 5777.8 5785.4 5790.3 5792.5 4121.2 4155.7 4159.9 4192.8 4196.7 5986.1 6143.8 6155.9 6157.2 6158.3 5816.3 5869.1 5897.4 5902.4 5906.7 5890.2 5895.2 5899.1 5908.7 5919.4 5653.6 5769.1 5771.4 5773.7 5777.0 5885.7 5916.9 5918.7 5942.9 5948.9 5752.4 5760.3 5765.9 5767.9 5768.9 10:17:51 INFO - 2015-12-10 10:17:51,426 DEBUG : BROWSER_OUTPUT: 10:17:51 INFO - 2015-12-10 10:17:51,426 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11962.26 Median:522.71 stddev:13790.59 (2638.3%) stddev-sans-first:13803.42 10:17:51 INFO - 2015-12-10 10:17:51,426 DEBUG : BROWSER_OUTPUT: Values: 716.1 718.4 736.9 753.2 776.5 11852.2 11983.2 12016.8 12066.6 12067.3 11511.4 11797.7 11836.9 11888.0 11945.9 808.9 814.5 824.9 826.3 831.9 815.4 816.7 823.4 823.6 824.2 859.8 861.3 865.1 867.0 867.8 839.4 843.9 846.1 848.2 852.9 630.4 632.2 633.4 633.6 636.9 11989.5 12089.9 12091.3 12121.4 12130.9 10771.7 10974.0 11178.8 11220.2 11412.3 9449.3 9525.5 9613.6 9789.2 9835.0 3125.6 3155.3 3157.8 3159.3 3175.2 40160.6 40719.6 40793.2 40973.2 41181.4 9232.9 9366.4 9516.1 9542.3 9869.0 15899.7 16027.0 16051.1 16081.7 16160.0 5913.2 5996.7 6102.0 6166.8 6175.7 3541.5 3554.2 3560.9 3579.4 3583.2 2860.1 2903.7 2913.8 2914.4 2915.6 513.8 518.4 520.6 521.9 525.3 394.6 404.2 404.6 415.0 424.0 7023.8 7392.7 7555.1 7665.3 7700.8 501.1 510.2 523.5 526.8 596.8 3377.2 3432.3 3461.5 3523.8 3550.1 46552.8 47809.8 47929.8 48031.0 48383.3 43914.0 43987.1 44253.3 44483.3 44995.6 40681.0 41829.0 42056.6 42064.4 42096.6 6851.8 6994.1 7039.4 7067.9 7118.5 30470.9 30499.7 30995.4 30996.4 31339.2 36851.4 40199.4 40796.6 40952.0 40991.8 8459.5 8596.2 8640.5 8684.2 8884.3 9137.5 9147.5 9253.9 9262.7 9416.7 9073.0 9129.9 9235.8 9404.2 9681.8 8705.7 8785.7 9038.6 10723.6 10782.3 9568.4 9943.4 10208.2 10387.4 10392.3 7703.1 7889.8 7912.2 8421.4 8712.7 7693.8 8273.5 8295.2 8306.8 8423.0 10:17:51 INFO - 2015-12-10 10:17:51,426 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:17:51 INFO - 2015-12-10 10:17:51,426 DEBUG : BROWSER_OUTPUT: 10:17:52 INFO - 2015-12-10 10:17:52,116 INFO : Browser exited with error code: 0 10:17:52 INFO - 2015-12-10 10:17:52,134 INFO : Completed test dromaeo_css (00:18:34) 10:17:52 INFO - 2015-12-10 10:17:52,134 INFO : Starting test kraken 10:17:52 INFO - 2015-12-10 10:17:52,135 DEBUG : operating with platform_type : linux_ 10:17:52 INFO - 2015-12-10 10:17:52,135 INFO : Initialising browser for kraken test... 10:17:52 INFO - 2015-12-10 10:17:52,141 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprhayuM/profile http://localhost:33795/getInfo.html 10:17:57 INFO - 2015-12-10 10:17:57,286 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:17:57 INFO - 2015-12-10 10:17:57,286 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:17:57 INFO - 2015-12-10 10:17:57,287 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:17:57 INFO - 2015-12-10 10:17:57,287 DEBUG : BROWSER_OUTPUT: __metrics 10:17:57 INFO - 2015-12-10 10:17:57,403 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] 10:17:58 INFO - 2015-12-10 10:17:58,356 INFO : Browser initialized. 10:17:58 INFO - 2015-12-10 10:17:58,356 INFO : Running cycle 1/1 for kraken test... 10:17:58 INFO - 2015-12-10 10:17:58,356 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprhayuM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:18:10 INFO - 2015-12-10 10:18:10,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 143269888 10:18:10 INFO - 2015-12-10 10:18:10,374 DEBUG : BROWSER_OUTPUT: 10:18:12 INFO - 2015-12-10 10:18:12,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33795/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33795/tests/kraken/driver.html?testName=audio-beat-detection) 10:18:13 INFO - 2015-12-10 10:18:13,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 143659008 10:18:13 INFO - 2015-12-10 10:18:13,548 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2015-12-10 10:18:16,351 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33795/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33795/tests/kraken/driver.html?testName=audio-dft) 10:18:16 INFO - 2015-12-10 10:18:16,944 DEBUG : BROWSER_OUTPUT: RSS: Main: 143040512 10:18:16 INFO - 2015-12-10 10:18:16,944 DEBUG : BROWSER_OUTPUT: 10:18:19 INFO - 2015-12-10 10:18:19,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33795/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33795/tests/kraken/driver.html?testName=audio-fft) 10:18:20 INFO - 2015-12-10 10:18:20,473 DEBUG : BROWSER_OUTPUT: RSS: Main: 138108928 10:18:20 INFO - 2015-12-10 10:18:20,473 DEBUG : BROWSER_OUTPUT: 10:18:22 INFO - 2015-12-10 10:18:22,527 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33795/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33795/tests/kraken/driver.html?testName=audio-oscillator) 10:18:23 INFO - 2015-12-10 10:18:23,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 138956800 10:18:23 INFO - 2015-12-10 10:18:23,141 DEBUG : BROWSER_OUTPUT: 10:18:25 INFO - 2015-12-10 10:18:25,348 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33795/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33795/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:18:25 INFO - 2015-12-10 10:18:25,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 140664832 10:18:25 INFO - 2015-12-10 10:18:25,934 DEBUG : BROWSER_OUTPUT: 10:18:29 INFO - 2015-12-10 10:18:29,014 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33795/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33795/tests/kraken/driver.html?testName=imaging-darkroom) 10:18:29 INFO - 2015-12-10 10:18:29,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 140976128 10:18:29 INFO - 2015-12-10 10:18:29,607 DEBUG : BROWSER_OUTPUT: 10:18:33 INFO - 2015-12-10 10:18:33,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33795/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33795/tests/kraken/driver.html?testName=imaging-desaturate) 10:18:33 INFO - 2015-12-10 10:18:33,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 138846208 10:18:33 INFO - 2015-12-10 10:18:33,697 DEBUG : BROWSER_OUTPUT: 10:18:36 INFO - 2015-12-10 10:18:36,616 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33795/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33795/tests/kraken/driver.html?testName=json-parse-financial) 10:18:37 INFO - 2015-12-10 10:18:37,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 139784192 10:18:37 INFO - 2015-12-10 10:18:37,218 DEBUG : BROWSER_OUTPUT: 10:18:38 INFO - 2015-12-10 10:18:38,987 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33795/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33795/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:18:39 INFO - 2015-12-10 10:18:39,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 141127680 10:18:39 INFO - 2015-12-10 10:18:39,569 DEBUG : BROWSER_OUTPUT: 10:18:41 INFO - 2015-12-10 10:18:41,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33795/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33795/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:18:42 INFO - 2015-12-10 10:18:42,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 140210176 10:18:42 INFO - 2015-12-10 10:18:42,094 DEBUG : BROWSER_OUTPUT: 10:18:44 INFO - 2015-12-10 10:18:44,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33795/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33795/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:18:44 INFO - 2015-12-10 10:18:44,890 DEBUG : BROWSER_OUTPUT: RSS: Main: 140341248 10:18:44 INFO - 2015-12-10 10:18:44,890 DEBUG : BROWSER_OUTPUT: 10:18:47 INFO - 2015-12-10 10:18:47,466 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33795/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:18:48 INFO - 2015-12-10 10:18:48,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 140750848 10:18:48 INFO - 2015-12-10 10:18:48,067 DEBUG : BROWSER_OUTPUT: 10:18:50 INFO - 2015-12-10 10:18:50,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:18:51 INFO - 2015-12-10 10:18:51,316 DEBUG : BROWSER_OUTPUT: RSS: Main: 141365248 10:18:51 INFO - 2015-12-10 10:18:51,317 DEBUG : BROWSER_OUTPUT: 10:18:53 INFO - 2015-12-10 10:18:53,073 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33795/tests/kraken/driver.html?testName=ai-astar) 10:18:53 INFO - 2015-12-10 10:18:53,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 140238848 10:18:53 INFO - 2015-12-10 10:18:53,323 DEBUG : BROWSER_OUTPUT: 10:18:53 INFO - 2015-12-10 10:18:53,327 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:18:53 INFO - 2015-12-10 10:18:53,327 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:18:53 INFO - 2015-12-10 10:18:53,327 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:18:53 INFO - 2015-12-10 10:18:53,327 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:18:53 INFO - 2015-12-10 10:18:53,327 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;108;112;113;113;125;112;110;112;113 10:18:53 INFO - 2015-12-10 10:18:53,327 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;134;159;179;133;168;159;133;175;149 10:18:53 INFO - 2015-12-10 10:18:53,327 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;165;168;163;164;167;166;164;165;167 10:18:53 INFO - 2015-12-10 10:18:53,327 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;81;73;74;74;74;136;73;72;75 10:18:53 INFO - 2015-12-10 10:18:53,328 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;134;94;95;97;130;95;95;127 10:18:53 INFO - 2015-12-10 10:18:53,328 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;110;111;110;110;110;109;111 10:18:53 INFO - 2015-12-10 10:18:53,328 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;150;147;147;148;149;147;149;148 10:18:53 INFO - 2015-12-10 10:18:53,328 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;98;96;96;96;95;96;96;96;95 10:18:53 INFO - 2015-12-10 10:18:53,328 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;72;74;73;73;75;73;74;77;73 10:18:53 INFO - 2015-12-10 10:18:53,328 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;68;70;69;70;69;69;70 10:18:53 INFO - 2015-12-10 10:18:53,328 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;85;87;84;86;94;86;87;95 10:18:53 INFO - 2015-12-10 10:18:53,328 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;126;122;125;131;125;130;125;123;126 10:18:53 INFO - 2015-12-10 10:18:53,328 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;157;140;148;156;144;152;148;147;134 10:18:53 INFO - 2015-12-10 10:18:53,328 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;71;71;69;71;68;70;69;71;70 10:18:53 INFO - 2015-12-10 10:18:53,328 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:18:53 INFO - 2015-12-10 10:18:53,329 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:18:53 INFO - 2015-12-10 10:18:53,329 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,776 10:18:53 INFO - 2015-12-10 10:18:53,329 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:18:53 INFO - 2015-12-10 10:18:53,329 DEBUG : BROWSER_OUTPUT: __startTimestamp1449771533325__endTimestamp 10:18:53 INFO - 2015-12-10 10:18:53,329 DEBUG : BROWSER_OUTPUT: 10:18:53 INFO - 2015-12-10 10:18:53,332 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:18:53 INFO - 2015-12-10 10:18:53,332 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:18:53 INFO - 2015-12-10 10:18:53,332 DEBUG : BROWSER_OUTPUT: 10:18:53 INFO - 2015-12-10 10:18:53,332 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.90 Median:112.50 stddev:4.53 (4.0%) stddev-sans-first:4.76 10:18:53 INFO - 2015-12-10 10:18:53,333 DEBUG : BROWSER_OUTPUT: Values: 111.0 108.0 112.0 113.0 113.0 125.0 112.0 110.0 112.0 113.0 10:18:53 INFO - 2015-12-10 10:18:53,333 DEBUG : BROWSER_OUTPUT: 10:18:53 INFO - 2015-12-10 10:18:53,333 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:154.80 Median:159.00 stddev:17.12 (10.8%) stddev-sans-first:18.09 10:18:53 INFO - 2015-12-10 10:18:53,333 DEBUG : BROWSER_OUTPUT: Values: 159.0 134.0 159.0 179.0 133.0 168.0 159.0 133.0 175.0 149.0 10:18:53 INFO - 2015-12-10 10:18:53,333 DEBUG : BROWSER_OUTPUT: 10:18:53 INFO - 2015-12-10 10:18:53,333 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:165.20 Median:165.50 stddev:1.75 (1.1%) stddev-sans-first:1.67 10:18:53 INFO - 2015-12-10 10:18:53,333 DEBUG : BROWSER_OUTPUT: Values: 163.0 165.0 168.0 163.0 164.0 167.0 166.0 164.0 165.0 167.0 10:18:53 INFO - 2015-12-10 10:18:53,333 DEBUG : BROWSER_OUTPUT: 10:18:53 INFO - 2015-12-10 10:18:53,333 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.40 Median:74.00 stddev:19.70 (26.6%) stddev-sans-first:20.66 10:18:53 INFO - 2015-12-10 10:18:53,333 DEBUG : BROWSER_OUTPUT: Values: 72.0 81.0 73.0 74.0 74.0 74.0 136.0 73.0 72.0 75.0 10:18:53 INFO - 2015-12-10 10:18:53,334 DEBUG : BROWSER_OUTPUT: 10:18:53 INFO - 2015-12-10 10:18:53,334 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.70 Median:95.00 stddev:17.09 (18.0%) stddev-sans-first:17.69 10:18:53 INFO - 2015-12-10 10:18:53,334 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 134.0 94.0 95.0 97.0 130.0 95.0 95.0 127.0 10:18:53 INFO - 2015-12-10 10:18:53,334 DEBUG : BROWSER_OUTPUT: 10:18:53 INFO - 2015-12-10 10:18:53,334 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 10:18:53 INFO - 2015-12-10 10:18:53,334 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 110.0 111.0 110.0 110.0 110.0 109.0 111.0 10:18:53 INFO - 2015-12-10 10:18:53,334 DEBUG : BROWSER_OUTPUT: 10:18:53 INFO - 2015-12-10 10:18:53,334 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 10:18:53 INFO - 2015-12-10 10:18:53,334 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 150.0 147.0 147.0 148.0 149.0 147.0 149.0 148.0 10:18:53 INFO - 2015-12-10 10:18:53,334 DEBUG : BROWSER_OUTPUT: 10:18:53 INFO - 2015-12-10 10:18:53,334 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 10:18:53 INFO - 2015-12-10 10:18:53,335 DEBUG : BROWSER_OUTPUT: Values: 95.0 98.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 10:18:53 INFO - 2015-12-10 10:18:53,335 DEBUG : BROWSER_OUTPUT: 10:18:53 INFO - 2015-12-10 10:18:53,335 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.70 Median:73.50 stddev:1.42 (1.9%) stddev-sans-first:1.48 10:18:53 INFO - 2015-12-10 10:18:53,335 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 74.0 73.0 73.0 75.0 73.0 74.0 77.0 73.0 10:18:53 INFO - 2015-12-10 10:18:53,335 DEBUG : BROWSER_OUTPUT: 10:18:53 INFO - 2015-12-10 10:18:53,335 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 10:18:53 INFO - 2015-12-10 10:18:53,335 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 68.0 70.0 69.0 70.0 69.0 69.0 70.0 10:18:53 INFO - 2015-12-10 10:18:53,335 DEBUG : BROWSER_OUTPUT: 10:18:53 INFO - 2015-12-10 10:18:53,336 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:86.50 stddev:4.02 (4.6%) stddev-sans-first:4.10 10:18:53 INFO - 2015-12-10 10:18:53,336 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 85.0 87.0 84.0 86.0 94.0 86.0 87.0 95.0 10:18:53 INFO - 2015-12-10 10:18:53,336 DEBUG : BROWSER_OUTPUT: 10:18:53 INFO - 2015-12-10 10:18:53,336 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:126.00 stddev:2.85 (2.3%) stddev-sans-first:2.93 10:18:53 INFO - 2015-12-10 10:18:53,336 DEBUG : BROWSER_OUTPUT: Values: 128.0 126.0 122.0 125.0 131.0 125.0 130.0 125.0 123.0 126.0 10:18:53 INFO - 2015-12-10 10:18:53,336 DEBUG : BROWSER_OUTPUT: 10:18:53 INFO - 2015-12-10 10:18:53,336 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.30 Median:148.00 stddev:7.67 (5.2%) stddev-sans-first:7.37 10:18:53 INFO - 2015-12-10 10:18:53,336 DEBUG : BROWSER_OUTPUT: Values: 137.0 157.0 140.0 148.0 156.0 144.0 152.0 148.0 147.0 134.0 10:18:53 INFO - 2015-12-10 10:18:53,336 DEBUG : BROWSER_OUTPUT: 10:18:53 INFO - 2015-12-10 10:18:53,336 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.50 stddev:1.05 (1.5%) stddev-sans-first:1.12 10:18:53 INFO - 2015-12-10 10:18:53,337 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 71.0 69.0 71.0 68.0 70.0 69.0 71.0 70.0 10:18:53 INFO - 2015-12-10 10:18:53,337 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:18:53 INFO - 2015-12-10 10:18:53,337 DEBUG : BROWSER_OUTPUT: 10:18:54 INFO - 2015-12-10 10:18:54,228 INFO : Browser exited with error code: 0 10:18:54 INFO - 2015-12-10 10:18:54,280 INFO : Completed test kraken (00:01:02) 10:18:54 INFO - 2015-12-10 10:18:54,280 INFO : Starting test v8_7 10:18:54 INFO - 2015-12-10 10:18:54,280 DEBUG : operating with platform_type : linux_ 10:18:54 INFO - 2015-12-10 10:18:54,280 INFO : Initialising browser for v8_7 test... 10:18:54 INFO - 2015-12-10 10:18:54,286 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuZQn2b/profile http://localhost:33795/getInfo.html 10:18:59 INFO - 2015-12-10 10:18:59,359 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:18:59 INFO - 2015-12-10 10:18:59,359 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:18:59 INFO - 2015-12-10 10:18:59,359 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:18:59 INFO - 2015-12-10 10:18:59,359 DEBUG : BROWSER_OUTPUT: __metrics 10:18:59 INFO - 2015-12-10 10:18:59,502 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] 10:19:00 INFO - 2015-12-10 10:19:00,528 INFO : Browser initialized. 10:19:00 INFO - 2015-12-10 10:19:00,528 INFO : Running cycle 1/1 for v8_7 test... 10:19:00 INFO - 2015-12-10 10:19:00,528 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuZQn2b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:19:12 INFO - 2015-12-10 10:19:12,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 142712832 10:19:12 INFO - 2015-12-10 10:19:12,568 DEBUG : BROWSER_OUTPUT: 10:19:33 INFO - 2015-12-10 10:19:33,965 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33795/tests/v8_7/run.html (next: http://localhost:33795/tests/v8_7/run.html) 10:19:34 INFO - 2015-12-10 10:19:34,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 138043392 10:19:34 INFO - 2015-12-10 10:19:34,215 DEBUG : BROWSER_OUTPUT: 10:19:34 INFO - 2015-12-10 10:19:34,217 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:19:34 INFO - 2015-12-10 10:19:34,217 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:19:34 INFO - 2015-12-10 10:19:34,217 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:19:34 INFO - 2015-12-10 10:19:34,217 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:19:34 INFO - 2015-12-10 10:19:34,217 DEBUG : BROWSER_OUTPUT: |0;Richards;166.27868307283006 10:19:34 INFO - 2015-12-10 10:19:34,217 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.46084625694044 10:19:34 INFO - 2015-12-10 10:19:34,217 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.58361391694723 10:19:34 INFO - 2015-12-10 10:19:34,217 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 10:19:34 INFO - 2015-12-10 10:19:34,218 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1050.420168067227 10:19:34 INFO - 2015-12-10 10:19:34,218 DEBUG : BROWSER_OUTPUT: |5;Earley;755.8578987150415 10:19:34 INFO - 2015-12-10 10:19:34,218 DEBUG : BROWSER_OUTPUT: |6;Boyer;12268.292682926829 10:19:34 INFO - 2015-12-10 10:19:34,218 DEBUG : BROWSER_OUTPUT: |7;RegExp;26368.42105263158 10:19:34 INFO - 2015-12-10 10:19:34,218 DEBUG : BROWSER_OUTPUT: |8;Splay;594.5303210463734 10:19:34 INFO - 2015-12-10 10:19:34,219 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 10:19:34 INFO - 2015-12-10 10:19:34,219 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:19:34 INFO - 2015-12-10 10:19:34,219 DEBUG : BROWSER_OUTPUT: __startTimestamp1449771574215__endTimestamp 10:19:34 INFO - 2015-12-10 10:19:34,219 DEBUG : BROWSER_OUTPUT: 10:19:34 INFO - 2015-12-10 10:19:34,219 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:19:34 INFO - 2015-12-10 10:19:34,220 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:19:34 INFO - 2015-12-10 10:19:34,220 DEBUG : BROWSER_OUTPUT: 10:19:34 INFO - 2015-12-10 10:19:34,220 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.28 Median:166.28 stddev:0.00 (0.0%) 10:19:34 INFO - 2015-12-10 10:19:34,220 DEBUG : BROWSER_OUTPUT: Values: 166.3 10:19:34 INFO - 2015-12-10 10:19:34,220 DEBUG : BROWSER_OUTPUT: 10:19:34 INFO - 2015-12-10 10:19:34,220 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.46 Median:191.46 stddev:0.00 (0.0%) 10:19:34 INFO - 2015-12-10 10:19:34,221 DEBUG : BROWSER_OUTPUT: Values: 191.5 10:19:34 INFO - 2015-12-10 10:19:34,221 DEBUG : BROWSER_OUTPUT: 10:19:34 INFO - 2015-12-10 10:19:34,222 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.58 Median:280.58 stddev:0.00 (0.0%) 10:19:34 INFO - 2015-12-10 10:19:34,222 DEBUG : BROWSER_OUTPUT: Values: 280.6 10:19:34 INFO - 2015-12-10 10:19:34,223 DEBUG : BROWSER_OUTPUT: 10:19:34 INFO - 2015-12-10 10:19:34,223 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 10:19:34 INFO - 2015-12-10 10:19:34,223 DEBUG : BROWSER_OUTPUT: Values: 5191.7 10:19:34 INFO - 2015-12-10 10:19:34,223 DEBUG : BROWSER_OUTPUT: 10:19:34 INFO - 2015-12-10 10:19:34,223 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1050.42 Median:1050.42 stddev:0.00 (0.0%) 10:19:34 INFO - 2015-12-10 10:19:34,223 DEBUG : BROWSER_OUTPUT: Values: 1050.4 10:19:34 INFO - 2015-12-10 10:19:34,223 DEBUG : BROWSER_OUTPUT: 10:19:34 INFO - 2015-12-10 10:19:34,223 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:755.86 Median:755.86 stddev:0.00 (0.0%) 10:19:34 INFO - 2015-12-10 10:19:34,223 DEBUG : BROWSER_OUTPUT: Values: 755.9 10:19:34 INFO - 2015-12-10 10:19:34,223 DEBUG : BROWSER_OUTPUT: 10:19:34 INFO - 2015-12-10 10:19:34,224 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 10:19:34 INFO - 2015-12-10 10:19:34,224 DEBUG : BROWSER_OUTPUT: Values: 12268.3 10:19:34 INFO - 2015-12-10 10:19:34,224 DEBUG : BROWSER_OUTPUT: 10:19:34 INFO - 2015-12-10 10:19:34,224 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26368.42 Median:26368.42 stddev:0.00 (0.0%) 10:19:34 INFO - 2015-12-10 10:19:34,224 DEBUG : BROWSER_OUTPUT: Values: 26368.4 10:19:34 INFO - 2015-12-10 10:19:34,224 DEBUG : BROWSER_OUTPUT: 10:19:34 INFO - 2015-12-10 10:19:34,224 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:594.53 Median:594.53 stddev:0.00 (0.0%) 10:19:34 INFO - 2015-12-10 10:19:34,224 DEBUG : BROWSER_OUTPUT: Values: 594.5 10:19:34 INFO - 2015-12-10 10:19:34,224 DEBUG : BROWSER_OUTPUT: 10:19:34 INFO - 2015-12-10 10:19:34,224 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 10:19:34 INFO - 2015-12-10 10:19:34,224 DEBUG : BROWSER_OUTPUT: Values: 4830.9 10:19:34 INFO - 2015-12-10 10:19:34,224 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:19:34 INFO - 2015-12-10 10:19:34,224 DEBUG : BROWSER_OUTPUT: 10:19:35 INFO - 2015-12-10 10:19:35,128 INFO : Browser exited with error code: 0 10:19:35 INFO - 2015-12-10 10:19:35,140 INFO : Completed test v8_7 (00:00:40) 10:19:35 INFO - 2015-12-10 10:19:35,236 INFO : Completed test suite (00:20:17) 10:19:35 INFO - 2015-12-10 10:19:35,237 DEBUG : Working with test: dromaeo_css 10:19:35 INFO - 2015-12-10 10:19:35,237 DEBUG : Generating results file: dromaeo_css 10:19:35 INFO - 2015-12-10 10:19:35,238 DEBUG : Working with test: kraken 10:19:35 INFO - 2015-12-10 10:19:35,238 DEBUG : Generating results file: kraken 10:19:35 INFO - 2015-12-10 10:19:35,238 INFO : javascript benchmark 10:19:35 INFO - 2015-12-10 10:19:35,238 DEBUG : Working with test: v8_7 10:19:35 INFO - 2015-12-10 10:19:35,238 DEBUG : Generating results file: v8_7 10:19:35 INFO - 2015-12-10 10:19:35,239 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:19:35 INFO - 2015-12-10 10:19:35,286 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 10:19:35 INFO - 2015-12-10 10:19:35,286 DEBUG : process_Request line: dromaeo_css 6207.77 graph.html#tests=[[72,132,43]] 10:19:35 INFO - 2015-12-10 10:19:35,286 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:19:35 INFO - 2015-12-10 10:19:35,312 DEBUG : process_Request line: kraken 1545.40 graph.html#tests=[[232,132,43]] 10:19:35 INFO - 2015-12-10 10:19:35,312 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:19:35 INFO - 2015-12-10 10:19:35,343 DEBUG : process_Request line: v8_7 21187.64 graph.html#tests=[[230,132,43]] 10:19:35 INFO - 2015-12-10 10:19:35,344 INFO : javascript benchmark 10:19:35 INFO - 2015-12-10 10:19:35,348 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2621.895124195032, 2669.4260733942197, 2697.635819164412, 2710.186943916826, 2713.0, 4514.954850451494, 4687.437507499097, 4698.318743782153, 4731.030138821542, 4753.572178503934, 4651.186042442576, 4652.720836749797, 4668.906621867561, 4708.7645617719145, 4868.926966095502, 4280.229558679436, 4345.674074444413, 4404.141192467454, 4428.0701052778795, 4483.3723278741, 4302.204092242945, 4317.76252306123, 4335.609795118438, 4408.42690450241, 4438.911221775563, 4214.91570168598, 4238.5761423857675, 4239.703220774547, 4290.4636920384955, 4365.454318210223, 4343.2182207202695, 4389.144116897206, 4402.141582391435, 4402.449693788277, 4427.070315233805, 4376.0, 4395.516493185747, 4405.933910991338, 4409.272470042439, 4444.533324000998, 4445.222086134913, 4547.977260113711, 4598.379218805452, 4686.484486706459, 4729.905401891977, 4992.775325110379, 5039.067772462106, 5050.772715227824, 5081.390233172043, 5115.258287548322, 5085.923711144335, 5087.669301495428, 5087.872803179913, 5090.389153301628, 5099.59203263738, 4503.932441013388, 4607.0785842831565, 4608.055348653518, 4613.469451013177, 4654.86035418938, 5125.384953805567, 5145.76844042019, 5164.793408263702, 5185.766640501187, 5222.2427747976335, 4944.258361245842, 4945.554900059012, 4954.108260513142, 4954.628402869799, 4991.900161996739, 4743.691660042086, 4857.53853383928, 4861.149298872683, 4983.352164218701, 5045.016221836707, 4993.27597498368, 5015.4733752956145, 5022.347094877642, 5030.195168772979, 5070.391553013588, 4991.425986011583, 4997.275395067695, 5000.449950505442, 5008.974955125274, 5072.9746351268, 4039.3940908863906, 4121.814518346681, 4130.669546436278, 4131.091159944807, 4134.669226461876, 3613.1689711366007, 3643.617420170844, 3676.6139555346303, 3679.3193259247123, 3699.3711069117776, 4299.806508707115, 4321.157374311979, 4342.435483387139, 4370.978145109254, 4415.492218394926, 4809.038192361541, 4860.3681521401995, 4908.509149085063, 5063.696178229245, 5067.5439210470495, 4347.847825326098, 4363.040131171138, 4365.585269399402, 4369.038811461473, 4422.646188304928, 4470.932936005963, 4481.910361792746, 4489.393931819228, 4493.4607847057905, 4538.115067561794, 4585.885352866138, 4702.200625893538, 4715.481297057252, 4804.054357985022, 4824.372831532019, 4956.752162391938, 4969.751512424436, 4975.10448119342, 4979.0, 4980.676256043345, 4677.859664210079, 4715.81136754526, 4722.763861806827, 4733.928991065206, 4760.976195119002, 4773.11697335994, 4874.731889746098, 4910.189818679878, 4943.382077240345, 4987.700737955734, 4963.429205641398, 5005.899882002413, 5014.924776128434, 5015.749212539431, 5030.597552195889, 4727.3854398927915, 4839.975800120977, 4849.442314133919, 4852.126617208936, 4890.242012487928, 4746.8101275948575, 4822.7829747660735, 4823.469418363907, 4830.396200474941, 4862.41651001882, 4708.5997690195345, 4728.929066064081, 4734.810607575796, 4803.135435621622, 4804.42346918372, 4697.8355757548325, 4813.807447702053, 4896.804127834846, 4905.656604037683, 4938.950610493849, 4713.198756211521, 4767.904641907212, 4771.475137734916, 4790.568848803624, 4832.124885693007], "unit": "ms", "name": "dojo.html", "value": 4594.584671030403}, {"lowerIsBetter": false, "replicates": [556.3740791609439, 569.2628046679547, 576.5848589015908, 583.2417856786177, 585.3385674188166, 35692.2861542769, 36497.0, 36542.26915461689, 36560.0, 36663.816680916556, 40324.39513407301, 40730.38904416429, 40880.0, 40883.386749198784, 40906.59093409065, 7903.604819759018, 8007.799805004893, 8080.636371363303, 8084.231997960184, 8089.271965523102, 7910.7626771196665, 7961.084475285329, 7969.322607578363, 7982.640781164861, 7991.041075071, 7909.0, 7974.202579742037, 7997.200279971986, 8014.358851291911, 8023.4383593148505, 7833.804154896116, 7908.762737117896, 7909.525428474252, 7913.208679132098, 7914.050313962304, 7872.0, 7974.0431148262, 7994.6002699864775, 8017.238362355567, 8017.839643207161, 37113.25773484515, 37475.437868431996, 37693.0, 37705.43441848347, 37715.0, 2693.2728163395773, 2731.4537092581563, 3197.1563181071347, 3219.5331676906953, 3245.075153581218, 28029.0, 28054.859725701444, 28305.716942830513, 28368.290792730346, 28369.432611347864, 3367.5285460035616, 3480.1473638958364, 3507.0, 3526.294741051774, 3635.800030998294, 217870.0, 218424.0, 219061.0, 219440.0, 219775.9999999984, 52219.47780522146, 56148.43851561432, 56507.71746141325, 56598.71700641471, 56643.0, 45181.54818451839, 59885.0, 60163.699181504686, 60186.39813601896, 60190.69904650449, 13327.933360333136, 13599.796003059764, 13655.590332290047, 13688.65778355549, 13807.378667959965, 9585.616575336908, 9617.855732164024, 9635.084666956627, 9675.0, 9703.175230105378, 18958.241670333307, 19380.515487112654, 19630.116644751022, 19640.901795490932, 19753.802461975483, 7539.208383119803, 7820.0, 7851.254130857559, 7924.286814186751, 7937.880931786028, 769.1923480345615, 772.420684486635, 814.2956342763467, 820.1388542030844, 845.3026253341018, 24395.51208975846, 24653.0, 24699.259022229362, 24723.0, 24798.504029919663, 908.7591788176138, 956.6508224498008, 986.2061040862031, 1011.8836333821557, 1056.2975621211963, 13224.942004639606, 13297.0, 15470.0, 15485.690286194213, 16058.277377517807, 311630.0, 316883.0, 319311.0, 319555.0, 320518.0, 48842.755786221554, 49204.50795492071, 49691.50308496941, 49707.751461242464, 49712.0, 1104.5581767293147, 1202.5790973159324, 1203.3983008495752, 1205.0600531585378, 1224.5224362498632, 26759.0, 26836.313480124885, 27267.863660682364, 27297.181084567495, 27376.45247095007, 39122.217555649295, 39199.2160156801, 39681.0, 39750.60249397469, 39750.60249397469, 249212.0, 250785.0, 251831.0, 252216.0, 252453.0, 28438.715612843607, 40575.0, 41962.37056444217, 42415.5758442424, 42534.0, 38248.235035299695, 38318.0, 39329.803350984206, 39337.0, 39359.80320098381, 32854.342913141125, 32869.0, 33440.0, 33706.79785420381, 33901.15247118842, 33078.669213307556, 33696.0, 33803.66196338005, 33853.66146338505, 33897.0, 32930.0, 32987.17532061718, 33260.33479330448, 33329.166770830925, 33393.165170870925, 28046.43907121887, 29238.853805730836, 30116.79532818663, 30253.697463025088, 30397.0, 24450.266492005267, 24914.252572422858, 25282.87358563269, 25398.0, 25510.489790204465], "unit": "ms", "name": "ext.html", "value": 17130.66853137573}, {"lowerIsBetter": false, "replicates": [343.7456282351059, 343.82121296925584, 346.32812344052536, 347.21529343683267, 347.32792047388307, 15094.094354338733, 15539.766903496457, 16244.0, 16865.40971066013, 17500.824991750094, 15293.388264469408, 15561.610959726013, 15587.220638968063, 15624.609384765386, 15895.52313430596, 4449.243628583141, 4572.314152877078, 4585.99108196198, 4587.036722288323, 4590.173768721629, 4620.19146649335, 4623.1678297906365, 4627.629789616823, 4635.629149668035, 4640.60554852838, 4581.518940511249, 4806.903861922777, 5053.898922021557, 5208.687478751268, 5239.266502689627, 5023.572996295319, 5059.544640982329, 5065.468125846806, 5106.591472682177, 5233.528982391603, 5290.365156181283, 5298.761555730001, 5323.361196656388, 5324.307839980816, 5331.333583302087, 11254.381009044499, 11453.37006464644, 14694.706105877929, 17725.911370443195, 17875.553111172194, 1738.5914310137107, 1746.3276638494144, 1770.2211027148142, 1771.2206629083162, 1811.9547011324692, 8667.956660216658, 8689.000764911989, 8727.781805454915, 8732.388732788708, 9149.359544831865, 1678.681050600382, 1710.144927536232, 1721.870859685516, 1729.3428497171121, 1730.4981555348934, 33803.32393352119, 35817.28365432677, 47932.52067479315, 48087.75956120197, 48374.75812620914, 10009.249306302056, 10047.0, 10107.191424686007, 10152.644657436955, 10178.033086856736, 12545.310007949467, 12647.683807904692, 12654.683632909067, 12658.493660253487, 12754.0, 7133.252353173402, 8384.706535271236, 8450.183210609748, 8561.957190214134, 8570.74287771368, 6867.450603951772, 6920.4809639277255, 7043.647817609099, 7080.327368899946, 7130.750423735248, 7503.212162722835, 7546.094468663686, 7559.395248380117, 7574.318311351894, 7611.65747541362, 2984.9701502984694, 2996.310848504856, 3060.709232622897, 3068.110248028047, 3081.3529158876886, 360.5223079419727, 379.0523690773067, 380.28506407953427, 383.6892117384927, 422.2968757019528, 10211.846822297672, 10429.895701043044, 10651.573937042587, 10659.573617055386, 10679.305845120043, 392.7074329624391, 413.0705911698678, 414.9232392007488, 424.1051381584854, 428.6570743405263, 5525.972370138124, 5737.770489180386, 5793.073108302651, 5825.213596164548, 5838.7080645967535, 516444.0, 523518.0, 523557.0, 524127.0, 529887.0, 71939.28060719326, 75537.24462755302, 76025.0, 76349.0, 76544.61727691325, 445.612317283965, 452.57231915839213, 453.62802501948084, 453.6733551842668, 453.90921815637006, 9753.31726779147, 9885.85171222418, 9927.453990030617, 9945.552450139905, 10121.0, 30686.846565767028, 33296.0, 34611.653883460844, 34870.30259394849, 35885.1028724284, 38230.0, 41323.793381034106, 41912.790436047624, 42070.36894446647, 42201.15597687968, 8510.61702223389, 8758.343124265579, 8908.10918908104, 8941.508217047865, 8945.686900958435, 8855.690050848189, 9118.361714679908, 9171.908280917105, 9501.334906556474, 16472.0, 8671.783205419915, 8852.867206992029, 8985.415947963624, 9080.818383632422, 9089.77275568116, 8974.14745599167, 9275.536223188948, 9367.391119577205, 9505.382150160218, 9665.758356041155, 9361.485118318558, 9364.625414983324, 9859.950700246452, 10099.192064634664, 10109.696709098738, 12936.417861196456, 13430.328483575588, 13459.259740714355, 14003.50987715425, 14049.648758781112, 14157.646058848612, 14186.716265674835, 14236.928815355857, 14489.275536223358, 14492.492762753252], "unit": "ms", "name": "jquery.html", "value": 7450.293514188588}, {"lowerIsBetter": false, "replicates": [1477.0177831741892, 1601.1433882872661, 1666.9583260418492, 1680.4286542575521, 1722.9310827566899, 5801.53587712983, 6118.785842495514, 6557.73769049238, 7010.7195712171515, 7057.2942705729465, 6414.935850641492, 6561.343865613437, 6569.572977756443, 6595.967020164892, 6609.735610575583, 2042.0708577597159, 2068.95862082759, 2069.368842503036, 2071.523549583589, 2072.1607748861734, 2034.9084291206857, 2057.434205593459, 2063.226290141197, 2087.634663933813, 2087.645100332947, 2003.509140260638, 2027.8276346510565, 2057.5987682401937, 2060.556980249246, 2067.3177851309033, 2069.9172033118657, 2090.1325949730917, 2090.5087304483436, 2108.399106254725, 2109.9261525846673, 2052.148358431264, 2057.989710051455, 2091.884946327951, 2092.3199960013058, 2098.4963608733947, 6845.452363810883, 6914.481413893978, 6925.0, 6934.445244380488, 6941.444684425234, 4042.0, 4102.200070986159, 4127.195196936598, 4141.64795992341, 4142.875713728593, 2672.7327267273313, 2684.7315268473194, 2721.18364490652, 2740.753332200092, 2754.1737478756295, 849.9362547808939, 864.1358641358642, 871.3769654696922, 887.7691800132012, 914.4741773480209, 8994.0, 9044.3668943174, 9135.40619859707, 9170.86243706345, 9175.862362064574, 3657.579378371468, 3699.519062521909, 3721.7580857244193, 3761.4921985531605, 3779.149691319431, 8034.83930321402, 8043.919560804434, 8047.114817370085, 8063.516189028677, 8064.395170362246, 4079.326911059701, 4089.468369112056, 4092.652124569445, 4107.856225032169, 4120.196561670506, 3307.6526964668365, 3404.8808291710166, 3709.9443508347395, 3731.5149030625844, 3768.660820526111, 3450.275442157175, 3479.8956031319103, 3491.5635545556806, 3497.2306092659574, 3500.544929159193, 1090.465671820802, 1098.4068602954476, 1100.2628239079836, 1101.7025403141106, 1106.3804269608884, 1146.157574182975, 1156.0982433701727, 1179.0096319092004, 1183.597576823884, 1204.1992075270023, 6708.798736037927, 6732.158480189976, 6740.9325906740305, 6748.0, 6761.729530818712, 996.7209181429066, 1002.5939494504737, 1012.3875055591409, 1015.2892974917587, 1018.974525636865, 5009.173486374781, 5098.97450512745, 5112.514311140436, 5115.8721031973755, 5146.279520867081, 8030.638621262057, 8204.753857384288, 8217.465864718773, 8548.74353769388, 8552.828943421096, 8347.332213422911, 8351.24838764514, 8369.49783013009, 8383.958080209683, 8390.454620449773, 6547.377999090078, 6563.934360656428, 6596.60420374779, 6671.0, 6726.125603671491, 6433.067205255305, 6436.517261205335, 6458.321876203119, 6471.611703297817, 6488.383603557654, 7331.230220826949, 7574.469787115069, 7590.0, 7598.126215485069, 7723.497972631761, 7324.63376831167, 7535.660895259617, 7561.4706970513735, 7792.88310675329, 7827.060752709711, 5935.465808077293, 6056.878862422815, 6069.514438844793, 6086.786962456293, 6151.692415379123, 6656.400923916871, 6694.866102678016, 6697.3637504437, 6708.295628959084, 6731.730730770714, 6221.875562488634, 6247.437730604267, 6268.561200715906, 6295.905561416491, 6453.515986300952, 6071.908921366095, 6095.786647467317, 6108.602940808833, 6110.419510146529, 6233.812985610439, 6353.936460635335, 6386.329435409215, 6386.680665966776, 6393.840153996187, 6408.231012278557, 5631.577631677558, 5649.887002260014, 5650.180723795109, 5682.829515114553, 5689.402612725769, 5901.409859014064, 6026.0, 6033.78881739137, 6040.1241819934985, 6055.939440605537], "unit": "ms", "name": "mootools.html", "value": 4035.783648977843}, {"lowerIsBetter": false, "replicates": [306.6473555411277, 307.7614848492418, 318.6415282806842, 319.4872230070736, 322.072431397575, 5473.452654734525, 5501.559875209983, 5588.30146231721, 5619.971900140498, 5627.493525582702, 5379.704116273603, 5487.6158668893095, 5487.780488780454, 5494.148406996912, 5502.5597952163835, 4304.053108316165, 4325.351197320396, 4333.133373325331, 4334.739915605058, 4357.847475338363, 4328.112736888946, 4333.176696427684, 4339.696221264513, 4355.041890784022, 4361.760103194323, 4102.835886564534, 4217.430646862665, 4303.117860838536, 4316.07204451043, 4318.417013703157, 4202.222588821078, 4208.768517731523, 4224.9155016899485, 4261.936070958938, 4269.444972153631, 3706.110533471974, 3712.3317802795486, 3712.9443058354145, 3713.1274150574595, 3717.20080182762, 5377.435369286247, 5380.085385484438, 5421.972890135564, 5426.891462170774, 5436.565074794007, 4681.274402467623, 4851.296561998491, 4866.975665121687, 4883.8779030524165, 4899.387576552931, 5650.406707295757, 5826.126081087871, 5829.504492118175, 5832.533397328203, 5838.9124163137585, 3965.088029753173, 3969.7419667721792, 3994.800259986989, 4012.7592344459426, 4017.015831121394, 6057.757689692407, 6138.0792881067755, 6139.355367686373, 6143.78496752616, 6150.600210986271, 3986.541547722049, 4126.256039733604, 4126.731762435432, 4135.669146468275, 4148.589479576958, 4181.519125300569, 4185.707000509996, 4210.6841986851105, 4214.220369231702, 4223.894402639959, 4786.497417771154, 4837.250226214872, 4848.17581011229, 4862.756862156878, 4883.560479556857, 5808.5062769665055, 5853.648781073064, 5855.268091488564, 5862.413758624103, 5870.442307980735, 1439.6976634906578, 1451.1583281696592, 1456.9635759106106, 1486.851314868526, 1495.1627088830073, 983.5770618634056, 997.9550920208608, 1008.1078245752415, 1009.162395211987, 1011.1001208924064, 4963.726995015237, 4965.776540055706, 4967.801287948514, 4968.254761785689, 4981.651284410129, 5896.498797602252, 5930.11048342752, 5978.760849566055, 6006.789762358297, 6010.278766548042, 5004.074246264453, 5025.070361982972, 5037.546620804072, 5042.294078828967, 5044.2937988681615, 3189.521571764254, 3193.3134376109247, 3228.9990103068126, 3239.627442844056, 3250.658680838525, 5632.549396048306, 5645.2096706461125, 5651.180578816049, 5660.094384898396, 5671.092625179951, 6139.140520327158, 6150.0, 6152.569320147547, 6155.907661385083, 6166.784162554289, 5617.9719101404235, 5638.633488823213, 5658.85852853682, 5663.263775709132, 5674.06377947634, 5948.39393363798, 6136.5090792737365, 6142.04798256271, 6157.568970172045, 6160.13758073861, 6023.578349515492, 6035.456808887221, 6042.456178943916, 6048.123022161674, 6053.757849685963, 5762.711864406847, 5777.826665200051, 5785.392533783892, 5790.276215473066, 5792.478676919098, 4121.185562903287, 4155.729877557949, 4159.854405095807, 4192.811323490511, 4196.706230563831, 5986.102084687158, 6143.754249829957, 6155.907661385172, 6157.199564056644, 6158.261008678808, 5816.331121921034, 5869.148973398918, 5897.3807750185615, 5902.350741418526, 5906.70466476683, 5890.175375447527, 5895.20414744004, 5899.056151015817, 5908.734106965111, 5919.437653422918, 5653.575981801464, 5769.105788602773, 5771.422857714195, 5773.74018169175, 5777.04678728022, 5885.705714714333, 5916.881662366643, 5918.73365698536, 5942.940570594239, 5948.940510595012, 5752.395998420106, 5760.308762948473, 5765.8558536036935, 5767.884642307215, 5768.94231057684], "unit": "ms", "name": "prototype.html", "value": 4368.168799026627}, {"lowerIsBetter": false, "replicates": [716.1406312425088, 718.3893690363192, 736.9388081163127, 753.1865585168019, 776.4681193382534, 11852.170348075639, 11983.221090629126, 12016.7596648067, 12066.577669781549, 12067.3362965037, 11511.42442877857, 11797.70505737357, 11836.940815295911, 11888.048956083514, 11945.880541194585, 808.8746244332124, 814.5397850214639, 824.9340052795762, 826.2893911236362, 831.8585840407145, 815.3640160674684, 816.6978218059327, 823.3948048184579, 823.5717426937989, 824.2087595907935, 859.8151397449548, 861.3496809908511, 865.1046167216932, 867.0202670981781, 867.7830542364409, 839.4082172068677, 843.9324854011664, 846.1369403208754, 848.1899785704668, 852.9360297977645, 630.3885231325606, 632.2255237334228, 633.4077637409038, 633.6388258692547, 636.8789929913302, 11989.520419183222, 12089.93955030228, 12091.334976576285, 12121.39393030345, 12130.878691213064, 10771.676849694444, 10974.0, 11178.832317515162, 11220.214584979054, 11412.258203216765, 9449.291303152222, 9525.476098814563, 9613.615455381776, 9789.167920726746, 9834.9508252459, 3125.6405513366026, 3155.2742869140225, 3157.8105313681253, 3159.273367125574, 3175.1744546417867, 40160.59839401598, 40719.59280407188, 40793.1841363174, 40973.1805363894, 41181.38227926583, 9232.8615070774, 9366.438013719198, 9516.143547080657, 9542.284328675238, 9869.0, 15899.694544291244, 16027.0, 16051.117188554508, 16081.67836643284, 16160.0, 5913.231279933581, 5996.70016499182, 6101.969490152521, 6166.81499555014, 6175.660338681416, 3541.5041894134843, 3554.20030493137, 3560.893173204808, 3579.3736096183065, 3583.1937813991644, 2860.070477094911, 2903.738663520251, 2913.810602310843, 2914.417116576693, 2915.5772412999995, 513.7816428018077, 518.4116028307823, 520.632953767593, 521.8695326168458, 525.2961032216772, 394.59159769638285, 404.2400287459557, 404.63582775502283, 414.9688773342011, 423.9872803815891, 7023.789286321418, 7392.667329970164, 7555.09338879338, 7665.348445382094, 7700.768976930701, 501.1080277106756, 510.1735188993854, 523.5419008367678, 526.8472143078541, 596.7523477756769, 3377.2401209728105, 3432.3478539077996, 3461.5326930864517, 3523.841427135785, 3550.094725844893, 46552.767236164276, 47809.76095119502, 47929.76035119802, 48031.0, 48383.274250886265, 43914.0, 43987.12025759531, 44253.336199957026, 44483.332750008776, 44995.550044499134, 40681.0, 41829.0, 42056.57943420588, 42064.36903446512, 42096.57903420988, 6851.794446166623, 6994.094030168499, 7039.436845052486, 7067.929320706933, 7118.5017048806085, 30470.933517326786, 30499.695003049685, 30995.380092397576, 30996.380072398875, 31339.216519587193, 36851.447228292134, 40199.397009045475, 40796.59203407928, 40952.0, 40991.795041024605, 8459.492430454193, 8596.183362580545, 8640.524771137396, 8684.176322971995, 8884.289256859307, 9137.543122843697, 9147.496887671243, 9253.86119208199, 9262.72211833646, 9416.670416535662, 9072.95463522678, 9129.90870091317, 9235.76910577241, 9404.153626173676, 9681.806363872824, 8705.6953006647, 8785.692500762443, 9038.63845446201, 10723.571057157626, 10782.299150555189, 9568.378055426376, 9943.403395796275, 10208.183345332503, 10387.428691421743, 10392.272540922062, 7703.114141873756, 7889.84220315579, 7912.169222231813, 8421.368397370345, 8712.651493940424, 7693.807654808675, 8273.46222495536, 8295.211954864279, 8306.750797476085, 8423.0], "unit": "ms", "name": "yui.html", "value": 5535.397694354185}], "name": "dromaeo_css", "value": 6207.770598229965}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 112.0, 113.0, 113.0, 125.0, 112.0, 110.0, 112.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 112.9}, {"lowerIsBetter": true, "replicates": [159.0, 134.0, 159.0, 179.0, 133.0, 168.0, 159.0, 133.0, 175.0, 149.0], "unit": "ms", "name": "audio-beat-detection", "value": 154.8}, {"lowerIsBetter": true, "replicates": [163.0, 165.0, 168.0, 163.0, 164.0, 167.0, 166.0, 164.0, 165.0, 167.0], "unit": "ms", "name": "audio-dft", "value": 165.2}, {"lowerIsBetter": true, "replicates": [72.0, 81.0, 73.0, 74.0, 74.0, 74.0, 136.0, 73.0, 72.0, 75.0], "unit": "ms", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 134.0, 94.0, 95.0, 97.0, 130.0, 95.0, 95.0, 127.0], "unit": "ms", "name": "audio-oscillator", "value": 105.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 111.0, 110.0, 110.0, 110.0, 109.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 150.0, 147.0, 147.0, 148.0, 149.0, 147.0, 149.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.1}, {"lowerIsBetter": true, "replicates": [95.0, 98.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 74.0, 73.0, 73.0, 75.0, 73.0, 74.0, 77.0, 73.0], "unit": "ms", "name": "json-parse-financial", "value": 73.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 70.0, 69.0, 70.0, 69.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 85.0, 87.0, 84.0, 86.0, 94.0, 86.0, 87.0, 95.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.2}, {"lowerIsBetter": true, "replicates": [128.0, 126.0, 122.0, 125.0, 131.0, 125.0, 130.0, 125.0, 123.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.1}, {"lowerIsBetter": true, "replicates": [137.0, 157.0, 140.0, 148.0, 156.0, 144.0, 152.0, 148.0, 147.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.3}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 69.0, 71.0, 68.0, 70.0, 69.0, 71.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1545.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.27868307283006], "unit": "score", "name": "Richards", "value": 212.306228}, {"lowerIsBetter": false, "replicates": [191.46084625694044], "unit": "score", "name": "DeltaBlue", "value": 345.33431399999995}, {"lowerIsBetter": false, "replicates": [280.58361391694723], "unit": "score", "name": "Encrypt", "value": 948.6690839999999}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1050.420168067227], "unit": "score", "name": "RayTrace", "value": 704.469528}, {"lowerIsBetter": false, "replicates": [755.8578987150415], "unit": "score", "name": "Earley", "value": 881.7305489999999}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [26368.42105263158], "unit": "score", "name": "RegExp", "value": 34.54833333333334}, {"lowerIsBetter": false, "replicates": [594.5303210463734], "unit": "score", "name": "Splay", "value": 137.06786199999996}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21187.63840458149}]} 10:19:35 INFO - RETURN: dromaeo_css: 6207.77 10:19:35 INFO - RETURN: kraken: 1545.40 10:19:35 INFO - RETURN: v8_7: 21187.64 10:19:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21187.64"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1545.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6207.77"}}} 10:19:35 INFO - Return code: 0 10:19:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:19:35 INFO - # TBPL SUCCESS # 10:19:35 INFO - Running post-action listener: _resource_record_post_action 10:19:35 INFO - Running post-run listener: _resource_record_post_run 10:19:36 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 517214208; Read time: 16; Write time: 486152 10:19:36 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 240795648; Read time: 0; Write time: 309368 10:19:36 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 272134144; Read time: 16; Write time: 175948 10:19:36 INFO - Running post-run listener: _upload_blobber_files 10:19:36 INFO - Blob upload gear active. 10:19:36 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:19:36 INFO - Copying logs to upload dir... 10:19:36 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.146834 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-10 10:19:34.099273) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 10:19:34.102873) ========= 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=20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009992 build_url: 'https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 10:19:34.154829) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 10:19:34.155472) ========= 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=20aa3857bbc5a756c598c738000001bb-1449764640.285744-886787892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 10:19:34.208832) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 10:19:34.209420) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 10:19:34.210123) ========= ========= Total master_lag: 0.23 =========