builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-054 starttime: 1450298373.59 results: success (0) buildid: 20151216114502 builduid: 65ac83e824e249959ccd21219d3cd1c9 revision: 2c0d64cea673b90bc49aa8d4cfa63787931782cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 12:39:33.593033) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 12:39:33.593512) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 12:39:33.593876) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006423 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 12:39:33.651068) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 12:39:33.651445) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 12:39:33.746339) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 12:39:33.746632) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004625 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 12:39:33.798911) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 12:39:33.799214) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 12:39:33.799638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 12:39:33.799946) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 12:39:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 82.0M=0s 2015-12-16 12:39:34 (82.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165986 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 12:39:33.986534) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 12:39:33.986861) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017153 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 12:39:34.037145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 12:39:34.037520) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2c0d64cea673b90bc49aa8d4cfa63787931782cc --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 2c0d64cea673b90bc49aa8d4cfa63787931782cc --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=752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 12:39:34,482 truncating revision to first 12 chars 2015-12-16 12:39:34,482 Setting DEBUG logging. 2015-12-16 12:39:34,482 attempt 1/10 2015-12-16 12:39:34,482 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2c0d64cea673?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 12:39:34,797 unpacking tar archive at: fx-team-2c0d64cea673/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659659 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 12:39:34.711474) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 12:39:34.712245) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 12:39:34.723801) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 12:39:34.724319) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 12:39:34.725039) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-16 12:39:34.725454) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:39:35 INFO - MultiFileLogger online at 20151216 12:39:35 in /builds/slave/test 12:39:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:39:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:39:35 INFO - {'append_to_log': False, 12:39:35 INFO - 'base_work_dir': '/builds/slave/test', 12:39:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:39:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:39:35 INFO - 'branch': 'Fx-Team-Non-PGO', 12:39:35 INFO - 'buildbot_json_path': 'buildprops.json', 12:39:35 INFO - 'config_files': ('talos/linux_config.py',), 12:39:35 INFO - 'default_actions': ('clobber', 12:39:35 INFO - 'read-buildbot-config', 12:39:35 INFO - 'download-and-extract', 12:39:35 INFO - 'populate-webroot', 12:39:35 INFO - 'create-virtualenv', 12:39:35 INFO - 'install', 12:39:35 INFO - 'run-tests'), 12:39:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:39:35 INFO - 'download_minidump_stackwalk': True, 12:39:35 INFO - 'download_symbols': 'ondemand', 12:39:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:39:35 INFO - 'tooltool.py': '/tools/tooltool.py', 12:39:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:39:35 INFO - '/tools/misc-python/virtualenv.py')}, 12:39:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:39:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:39:35 INFO - 'installer_path': 'installer.exe', 12:39:35 INFO - 'log_level': 'info', 12:39:35 INFO - 'log_name': 'talos', 12:39:35 INFO - 'log_to_console': True, 12:39:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:39:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:39:35 INFO - 'opt_config_files': (), 12:39:35 INFO - 'pip_index': False, 12:39:35 INFO - 'sps_profile': False, 12:39:35 INFO - 'sps_profile_interval': 0, 12:39:35 INFO - 'suite': 'dromaeojs', 12:39:35 INFO - 'system_bits': '64', 12:39:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:39:35 INFO - 'title': 'talos-linux64-ix-054', 12:39:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:39:35 INFO - 'use_talos_json': True, 12:39:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:39:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:39:35 INFO - 'work_dir': 'build'} 12:39:35 INFO - ##### 12:39:35 INFO - ##### Running clobber step. 12:39:35 INFO - ##### 12:39:35 INFO - Running pre-action listener: _resource_record_pre_action 12:39:35 INFO - Running main action method: clobber 12:39:35 INFO - rmtree: /builds/slave/test/build 12:39:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:39:35 INFO - Running post-action listener: _resource_record_post_action 12:39:35 INFO - ##### 12:39:35 INFO - ##### Running read-buildbot-config step. 12:39:35 INFO - ##### 12:39:35 INFO - Running pre-action listener: _resource_record_pre_action 12:39:35 INFO - Running main action method: read_buildbot_config 12:39:35 INFO - Using buildbot properties: 12:39:35 INFO - { 12:39:35 INFO - "project": "", 12:39:35 INFO - "product": "firefox", 12:39:35 INFO - "script_repo_revision": "production", 12:39:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:39:35 INFO - "repository": "", 12:39:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:39:35 INFO - "buildid": "20151216114502", 12:39:35 INFO - "pgo_build": "False", 12:39:35 INFO - "basedir": "/builds/slave/test", 12:39:35 INFO - "buildnumber": 1017, 12:39:35 INFO - "slavename": "talos-linux64-ix-054", 12:39:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:39:35 INFO - "platform": "ubuntu64_hw", 12:39:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:39:35 INFO - "branch": "fx-team", 12:39:35 INFO - "repo_path": "integration/fx-team", 12:39:35 INFO - "revision": "2c0d64cea673b90bc49aa8d4cfa63787931782cc", 12:39:35 INFO - "stage_platform": "linux64", 12:39:35 INFO - "builduid": "65ac83e824e249959ccd21219d3cd1c9", 12:39:35 INFO - "slavebuilddir": "test" 12:39:35 INFO - } 12:39:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 12:39:35 INFO - Running post-action listener: _resource_record_post_action 12:39:35 INFO - ##### 12:39:35 INFO - ##### Running download-and-extract step. 12:39:35 INFO - ##### 12:39:35 INFO - Running pre-action listener: _resource_record_pre_action 12:39:35 INFO - Running main action method: download_and_extract 12:39:35 INFO - mkdir: /builds/slave/test/build/tests 12:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:35 INFO - https://queue.taskcluster.net/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:39:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/test_packages.json 12:39:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/test_packages.json 12:39:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:39:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:39:37 INFO - Downloaded 1302 bytes. 12:39:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:39:37 INFO - Using the following test package requirements: 12:39:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:39:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:39:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:37 INFO - u'jsshell-linux-x86_64.zip'], 12:39:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:39:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:39:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:39:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:39:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:39:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:39:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:39:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:37 INFO - https://queue.taskcluster.net/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:39:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:39:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:39:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:39:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:39:38 INFO - Downloaded 21870297 bytes. 12:39:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 12:39:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:39:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:39:39 INFO - Return code: 0 12:39:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:39:39 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')]} 12:39:39 INFO - https://queue.taskcluster.net/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:39:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:39:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:39:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:39:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:39:48 INFO - Downloaded 21870297 bytes. 12:39:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 12:39:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:39:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:39:49 INFO - Return code: 0 12:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:49 INFO - https://queue.taskcluster.net/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:39:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:39:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:39:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:39:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:39:50 INFO - Downloaded 11132052 bytes. 12:39:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 12:39:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:39:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 12:39:50 INFO - Return code: 0 12:39:50 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')]} 12:39:50 INFO - https://queue.taskcluster.net/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:39:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:39:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:39:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:39:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:39:52 INFO - Downloaded 57772574 bytes. 12:39:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:39:52 INFO - mkdir: /builds/slave/test/properties 12:39:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:39:52 INFO - Writing to file /builds/slave/test/properties/build_url 12:39:52 INFO - Contents: 12:39:52 INFO - build_url:https://queue.taskcluster.net/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:39:52 INFO - Running post-action listener: _resource_record_post_action 12:39:52 INFO - Running post-action listener: set_extra_try_arguments 12:39:52 INFO - ##### 12:39:52 INFO - ##### Running populate-webroot step. 12:39:52 INFO - ##### 12:39:52 INFO - Running pre-action listener: _resource_record_pre_action 12:39:52 INFO - Running main action method: populate_webroot 12:39:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:39:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:39:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:39:52 INFO - '--tppagecycles', 12:39:52 INFO - '7'], 12:39:52 INFO - 'tests': ['tsvgm']}}, 12:39:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:39:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:39:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:39:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:39:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:39:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:39:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:39:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:52 INFO - 'talos_options': ['--e10s'], 12:39:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:39:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:52 INFO - 'tests': ['damp', 'tps']}, 12:39:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:52 INFO - 'talos_options': ['--e10s'], 12:39:52 INFO - 'tests': ['damp', 'tps']}, 12:39:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:39:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:39:52 INFO - 'other': {'tests': ['a11yr', 12:39:52 INFO - 'ts_paint', 12:39:52 INFO - 'tpaint', 12:39:52 INFO - 'sessionrestore', 12:39:52 INFO - 'sessionrestore_no_auto_restore']}, 12:39:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:39:52 INFO - 'tests': ['a11yr', 12:39:52 INFO - 'ts_paint', 12:39:52 INFO - 'tpaint', 12:39:52 INFO - 'sessionrestore', 12:39:52 INFO - 'sessionrestore_no_auto_restore']}, 12:39:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:39:52 INFO - 'tests': ['a11yr', 12:39:52 INFO - 'ts_paint', 12:39:52 INFO - 'tpaint', 12:39:52 INFO - 'sessionrestore', 12:39:52 INFO - 'sessionrestore_no_auto_restore']}, 12:39:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:39:52 INFO - 'tests': ['a11yr', 12:39:52 INFO - 'ts_paint', 12:39:52 INFO - 'tpaint', 12:39:52 INFO - 'sessionrestore', 12:39:52 INFO - 'sessionrestore_no_auto_restore']}, 12:39:52 INFO - 'other_l64': {'tests': ['a11yr', 12:39:52 INFO - 'ts_paint', 12:39:52 INFO - 'tpaint', 12:39:52 INFO - 'sessionrestore', 12:39:52 INFO - 'sessionrestore_no_auto_restore']}, 12:39:52 INFO - 'other_nol64': {'tests': ['a11yr', 12:39:52 INFO - 'ts_paint', 12:39:52 INFO - 'tpaint', 12:39:52 INFO - 'sessionrestore', 12:39:52 INFO - 'sessionrestore_no_auto_restore']}, 12:39:52 INFO - 'svgr': {'tests': ['tsvgx', 12:39:52 INFO - 'tsvgr_opacity', 12:39:52 INFO - 'tart', 12:39:52 INFO - 'tscrollx', 12:39:52 INFO - 'cart']}, 12:39:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:39:52 INFO - 'tests': ['tsvgx', 12:39:52 INFO - 'tsvgr_opacity', 12:39:52 INFO - 'tart', 12:39:52 INFO - 'tscrollx', 12:39:52 INFO - 'cart']}, 12:39:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:52 INFO - 'tests': ['tp5o']}, 12:39:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:52 INFO - 'talos_options': ['--e10s'], 12:39:52 INFO - 'tests': ['tp5o']}, 12:39:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:52 INFO - 'talos_options': ['--xperf_path', 12:39:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:39:52 INFO - 'tests': ['tp5n']}, 12:39:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:52 INFO - 'talos_options': ['--e10s', 12:39:52 INFO - '--xperf_path', 12:39:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:39:52 INFO - 'tests': ['tp5n']}}, 12:39:52 INFO - 'talos.zip': {'path': '', 12:39:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:39:52 INFO - Running post-action listener: _resource_record_post_action 12:39:52 INFO - ##### 12:39:52 INFO - ##### Running create-virtualenv step. 12:39:52 INFO - ##### 12:39:52 INFO - Running pre-action listener: _resource_record_pre_action 12:39:52 INFO - Running main action method: create_virtualenv 12:39:52 INFO - Creating virtualenv /builds/slave/test/build/venv 12:39:52 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 12:39:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:39:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:39:52 INFO - Using real prefix '/usr' 12:39:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:39:53 INFO - Installing distribute.............................................................................................................................................................................................done. 12:39:55 INFO - Installing pip.................done. 12:39:55 INFO - Return code: 0 12:39:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:39: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')]} 12:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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')]} 12:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f00cf5a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2417240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a60b0>, '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 0x24a6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a7440>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929', '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 12:39: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', 'pip>=1.5'] in /builds/slave/test/build 12:39: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 pip>=1.5 12:39:55 INFO - Using env: {'DISPLAY': ':0', 12:39:55 INFO - 'HOME': '/home/cltbld', 12:39:55 INFO - 'LANG': 'en_US.UTF-8', 12:39:55 INFO - 'LANGUAGE': 'en_US:en', 12:39:55 INFO - 'LOGNAME': 'cltbld', 12:39:55 INFO - 'MAIL': '/var/mail/cltbld', 12:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:55 INFO - 'MOZ_NO_REMOTE': '1', 12:39:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:55 INFO - 'NO_EM_RESTART': '1', 12:39:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:55 INFO - 'PWD': '/builds/slave/test', 12:39:55 INFO - 'SHELL': '/bin/bash', 12:39:55 INFO - 'SHLVL': '1', 12:39:55 INFO - 'TERM': 'linux', 12:39:55 INFO - 'TMOUT': '86400', 12:39:55 INFO - 'USER': 'cltbld', 12:39:55 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929', 12:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:55 INFO - '_': '/tools/buildbot/bin/python'} 12:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:55 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 12:39:55 INFO - Cleaning up... 12:39:55 INFO - Return code: 0 12:39:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:39: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')]} 12:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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')]} 12:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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', '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 0x7f00cf5a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2417240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a60b0>, '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 0x24a6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a7440>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929', '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 12:39: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', 'psutil>=0.7.1'] in /builds/slave/test/build 12:39: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 psutil>=0.7.1 12:39:55 INFO - Using env: {'DISPLAY': ':0', 12:39:55 INFO - 'HOME': '/home/cltbld', 12:39:55 INFO - 'LANG': 'en_US.UTF-8', 12:39:55 INFO - 'LANGUAGE': 'en_US:en', 12:39:55 INFO - 'LOGNAME': 'cltbld', 12:39:55 INFO - 'MAIL': '/var/mail/cltbld', 12:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:55 INFO - 'MOZ_NO_REMOTE': '1', 12:39:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:55 INFO - 'NO_EM_RESTART': '1', 12:39:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:55 INFO - 'PWD': '/builds/slave/test', 12:39:55 INFO - 'SHELL': '/bin/bash', 12:39:55 INFO - 'SHLVL': '1', 12:39:55 INFO - 'TERM': 'linux', 12:39:55 INFO - 'TMOUT': '86400', 12:39:55 INFO - 'USER': 'cltbld', 12:39:55 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929', 12:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:55 INFO - '_': '/tools/buildbot/bin/python'} 12:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:55 INFO - Downloading/unpacking psutil>=0.7.1 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39:57 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:39:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:39:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:39:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:39:57 INFO - Installing collected packages: psutil 12:39:57 INFO - Running setup.py install for psutil 12:39:57 INFO - building 'psutil._psutil_linux' extension 12:39:57 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 12:39:57 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 12:39:57 INFO - building 'psutil._psutil_posix' extension 12:39:57 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 12:39:57 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 12:39:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:39:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:39:57 INFO - Successfully installed psutil 12:39:57 INFO - Cleaning up... 12:39:57 INFO - Return code: 0 12:39:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:39:57 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')]} 12:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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')]} 12:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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', '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 0x7f00cf5a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2417240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a60b0>, '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 0x24a6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a7440>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929', '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 12:39: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:39: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 mozsystemmonitor==0.0.0 12:39:58 INFO - Using env: {'DISPLAY': ':0', 12:39:58 INFO - 'HOME': '/home/cltbld', 12:39:58 INFO - 'LANG': 'en_US.UTF-8', 12:39:58 INFO - 'LANGUAGE': 'en_US:en', 12:39:58 INFO - 'LOGNAME': 'cltbld', 12:39:58 INFO - 'MAIL': '/var/mail/cltbld', 12:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:58 INFO - 'MOZ_NO_REMOTE': '1', 12:39:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:58 INFO - 'NO_EM_RESTART': '1', 12:39:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:58 INFO - 'PWD': '/builds/slave/test', 12:39:58 INFO - 'SHELL': '/bin/bash', 12:39:58 INFO - 'SHLVL': '1', 12:39:58 INFO - 'TERM': 'linux', 12:39:58 INFO - 'TMOUT': '86400', 12:39:58 INFO - 'USER': 'cltbld', 12:39:58 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929', 12:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:58 INFO - '_': '/tools/buildbot/bin/python'} 12:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:39:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:39:59 INFO - Installing collected packages: mozsystemmonitor 12:39:59 INFO - Running setup.py install for mozsystemmonitor 12:40:00 INFO - Successfully installed mozsystemmonitor 12:40:00 INFO - Cleaning up... 12:40:00 INFO - Return code: 0 12:40:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:40:00 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')]} 12:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:00 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')]} 12:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:00 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 0x7f00cf5a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2417240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a60b0>, '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 0x24a6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a7440>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929', '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 12:40:00 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 12:40:00 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 12:40:00 INFO - Using env: {'DISPLAY': ':0', 12:40:00 INFO - 'HOME': '/home/cltbld', 12:40:00 INFO - 'LANG': 'en_US.UTF-8', 12:40:00 INFO - 'LANGUAGE': 'en_US:en', 12:40:00 INFO - 'LOGNAME': 'cltbld', 12:40:00 INFO - 'MAIL': '/var/mail/cltbld', 12:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:00 INFO - 'MOZ_NO_REMOTE': '1', 12:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:00 INFO - 'NO_EM_RESTART': '1', 12:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:00 INFO - 'PWD': '/builds/slave/test', 12:40:00 INFO - 'SHELL': '/bin/bash', 12:40:00 INFO - 'SHLVL': '1', 12:40:00 INFO - 'TERM': 'linux', 12:40:00 INFO - 'TMOUT': '86400', 12:40:00 INFO - 'USER': 'cltbld', 12:40:00 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929', 12:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:00 INFO - '_': '/tools/buildbot/bin/python'} 12:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:00 INFO - Downloading/unpacking blobuploader==1.2.4 12:40: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 12:40: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 12:40: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 12:40: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 12:40: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 12:40: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 12:40:01 INFO - Downloading blobuploader-1.2.4.tar.gz 12:40:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:40:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:40:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:02 INFO - Downloading docopt-0.6.1.tar.gz 12:40:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:40:02 INFO - Installing collected packages: blobuploader, requests, docopt 12:40:02 INFO - Running setup.py install for blobuploader 12:40:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:40:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:40:02 INFO - Running setup.py install for requests 12:40:03 INFO - Running setup.py install for docopt 12:40:03 INFO - Successfully installed blobuploader requests docopt 12:40:03 INFO - Cleaning up... 12:40:03 INFO - Return code: 0 12:40:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:40:03 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')]} 12:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:03 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')]} 12:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:03 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 0x7f00cf5a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2417240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a60b0>, '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 0x24a6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a7440>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929', '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 12:40:03 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 12:40:03 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 12:40:03 INFO - Using env: {'DISPLAY': ':0', 12:40:03 INFO - 'HOME': '/home/cltbld', 12:40:03 INFO - 'LANG': 'en_US.UTF-8', 12:40:03 INFO - 'LANGUAGE': 'en_US:en', 12:40:03 INFO - 'LOGNAME': 'cltbld', 12:40:03 INFO - 'MAIL': '/var/mail/cltbld', 12:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:03 INFO - 'MOZ_NO_REMOTE': '1', 12:40:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:03 INFO - 'NO_EM_RESTART': '1', 12:40:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:03 INFO - 'PWD': '/builds/slave/test', 12:40:03 INFO - 'SHELL': '/bin/bash', 12:40:03 INFO - 'SHLVL': '1', 12:40:03 INFO - 'TERM': 'linux', 12:40:03 INFO - 'TMOUT': '86400', 12:40:03 INFO - 'USER': 'cltbld', 12:40:03 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929', 12:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:03 INFO - '_': '/tools/buildbot/bin/python'} 12:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:40:03 INFO - Running setup.py (path:/tmp/pip-KjWVXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:40:03 INFO - Running setup.py (path:/tmp/pip-KsqwBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:40:03 INFO - Running setup.py (path:/tmp/pip-xwqCi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:40:03 INFO - Running setup.py (path:/tmp/pip-QdAxvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:40:03 INFO - Running setup.py (path:/tmp/pip-Uao8ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:40:03 INFO - Running setup.py (path:/tmp/pip-tmKmJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:40:03 INFO - Running setup.py (path:/tmp/pip-f7KoG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:40:04 INFO - Running setup.py (path:/tmp/pip-VbP_00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:40:04 INFO - Running setup.py (path:/tmp/pip-2aQcSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:40:04 INFO - Running setup.py (path:/tmp/pip-7ZOYsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:40:04 INFO - Running setup.py (path:/tmp/pip-BHVYZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:40:04 INFO - Running setup.py (path:/tmp/pip-NtjTMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:40:04 INFO - Running setup.py (path:/tmp/pip-bULAUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:40:04 INFO - Running setup.py (path:/tmp/pip-b6XoXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:04 INFO - Running setup.py (path:/tmp/pip-OpRF5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:40:04 INFO - Running setup.py (path:/tmp/pip-nG1_C5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:40:04 INFO - Running setup.py (path:/tmp/pip-e6t53z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:40:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:40:04 INFO - Running setup.py install for manifestparser 12:40:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:40:04 INFO - Running setup.py install for mozcrash 12:40:04 INFO - Running setup.py install for mozdebug 12:40:05 INFO - Running setup.py install for mozdevice 12:40:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:40:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:40:05 INFO - Running setup.py install for mozfile 12:40:05 INFO - Running setup.py install for mozhttpd 12:40:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:40:05 INFO - Running setup.py install for mozinfo 12:40:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:40:05 INFO - Running setup.py install for mozInstall 12:40:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:40:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:40:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:40:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:40:05 INFO - Running setup.py install for mozleak 12:40:05 INFO - Running setup.py install for mozlog 12:40:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:40:05 INFO - Running setup.py install for moznetwork 12:40:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:40:05 INFO - Running setup.py install for mozprocess 12:40:06 INFO - Running setup.py install for mozprofile 12:40:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:40:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:40:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:40:06 INFO - Running setup.py install for mozrunner 12:40:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:40:06 INFO - Running setup.py install for mozscreenshot 12:40:06 INFO - Running setup.py install for moztest 12:40:06 INFO - Running setup.py install for mozversion 12:40:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:40:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:40:06 INFO - Cleaning up... 12:40:06 INFO - Return code: 0 12:40:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:40:06 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')]} 12:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:06 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')]} 12:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:06 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 0x7f00cf5a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2417240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a60b0>, '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 0x24a6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a7440>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929', '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 12:40:06 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 12:40:06 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 12:40:06 INFO - Using env: {'DISPLAY': ':0', 12:40:06 INFO - 'HOME': '/home/cltbld', 12:40:06 INFO - 'LANG': 'en_US.UTF-8', 12:40:06 INFO - 'LANGUAGE': 'en_US:en', 12:40:06 INFO - 'LOGNAME': 'cltbld', 12:40:06 INFO - 'MAIL': '/var/mail/cltbld', 12:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:06 INFO - 'MOZ_NO_REMOTE': '1', 12:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:06 INFO - 'NO_EM_RESTART': '1', 12:40:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:06 INFO - 'PWD': '/builds/slave/test', 12:40:06 INFO - 'SHELL': '/bin/bash', 12:40:06 INFO - 'SHLVL': '1', 12:40:06 INFO - 'TERM': 'linux', 12:40:06 INFO - 'TMOUT': '86400', 12:40:06 INFO - 'USER': 'cltbld', 12:40:06 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929', 12:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:06 INFO - '_': '/tools/buildbot/bin/python'} 12:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:40:06 INFO - Running setup.py (path:/tmp/pip-WypPeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:40:06 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)) 12:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:40:06 INFO - Running setup.py (path:/tmp/pip-5MY50Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:40:06 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)) 12:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:40:06 INFO - Running setup.py (path:/tmp/pip-3PP4L0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:40:06 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)) 12:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:40:06 INFO - Running setup.py (path:/tmp/pip-Y8O8vS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:40:07 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)) 12:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:40:07 INFO - Running setup.py (path:/tmp/pip-xDzS_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:40:07 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)) 12:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:40:07 INFO - Running setup.py (path:/tmp/pip-3iy9B_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:40:07 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)) 12:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:40:07 INFO - Running setup.py (path:/tmp/pip-lhOpiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:40:07 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)) 12:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:40:07 INFO - Running setup.py (path:/tmp/pip-poEfsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:40:07 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)) 12:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:40:07 INFO - Running setup.py (path:/tmp/pip-E2JHwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:40:07 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)) 12:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:40:07 INFO - Running setup.py (path:/tmp/pip-RgvRf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:40:07 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)) 12:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:40:07 INFO - Running setup.py (path:/tmp/pip-zimVDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:40:07 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)) 12:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:40:07 INFO - Running setup.py (path:/tmp/pip-CK9lZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:40:07 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)) 12:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:40:07 INFO - Running setup.py (path:/tmp/pip-lz_sx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:40:07 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)) 12:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:40:07 INFO - Running setup.py (path:/tmp/pip-V7ZE6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:40:07 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)) 12:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:07 INFO - Running setup.py (path:/tmp/pip-2q_DW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:07 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)) 12:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:40:07 INFO - Running setup.py (path:/tmp/pip-SoFZVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:40:07 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)) 12:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:40:07 INFO - Running setup.py (path:/tmp/pip-hCf32U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:40:08 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)) 12:40:08 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)) 12:40:08 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)) 12:40:08 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)) 12:40:08 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)) 12:40:08 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)) 12:40:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:40:08 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 12:40:08 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 12:40:08 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 12:40:08 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 12:40:08 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 12:40:08 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 12:40:09 INFO - Downloading blessings-1.5.1.tar.gz 12:40:09 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 12:40:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:40:09 INFO - Installing collected packages: blessings 12:40:09 INFO - Running setup.py install for blessings 12:40:09 INFO - Successfully installed blessings 12:40:09 INFO - Cleaning up... 12:40:09 INFO - Return code: 0 12:40:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:40:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:40:10 INFO - Reading from file tmpfile_stdout 12:40:10 INFO - Current package versions: 12:40:10 INFO - argparse == 1.2.1 12:40:10 INFO - blessings == 1.5.1 12:40:10 INFO - blobuploader == 1.2.4 12:40:10 INFO - docopt == 0.6.1 12:40:10 INFO - manifestparser == 1.1 12:40:10 INFO - mozInstall == 1.12 12:40:10 INFO - mozcrash == 0.16 12:40:10 INFO - mozdebug == 0.1 12:40:10 INFO - mozdevice == 0.47 12:40:10 INFO - mozfile == 1.2 12:40:10 INFO - mozhttpd == 0.7 12:40:10 INFO - mozinfo == 0.9 12:40:10 INFO - mozleak == 0.1 12:40:10 INFO - mozlog == 3.1 12:40:10 INFO - moznetwork == 0.27 12:40:10 INFO - mozprocess == 0.22 12:40:10 INFO - mozprofile == 0.27 12:40:10 INFO - mozrunner == 6.11 12:40:10 INFO - mozscreenshot == 0.1 12:40:10 INFO - mozsystemmonitor == 0.0 12:40:10 INFO - moztest == 0.7 12:40:10 INFO - mozversion == 1.4 12:40:10 INFO - psutil == 3.1.1 12:40:10 INFO - requests == 1.2.3 12:40:10 INFO - wsgiref == 0.1.2 12:40:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:40:10 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')]} 12:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:10 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')]} 12:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:10 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 0x7f00cf5a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2417240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a60b0>, '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 0x24a6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a7440>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929', '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 12:40:10 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 12:40:10 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 12:40:10 INFO - Using env: {'DISPLAY': ':0', 12:40:10 INFO - 'HOME': '/home/cltbld', 12:40:10 INFO - 'LANG': 'en_US.UTF-8', 12:40:10 INFO - 'LANGUAGE': 'en_US:en', 12:40:10 INFO - 'LOGNAME': 'cltbld', 12:40:10 INFO - 'MAIL': '/var/mail/cltbld', 12:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:10 INFO - 'MOZ_NO_REMOTE': '1', 12:40:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:10 INFO - 'NO_EM_RESTART': '1', 12:40:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:10 INFO - 'PWD': '/builds/slave/test', 12:40:10 INFO - 'SHELL': '/bin/bash', 12:40:10 INFO - 'SHLVL': '1', 12:40:10 INFO - 'TERM': 'linux', 12:40:10 INFO - 'TMOUT': '86400', 12:40:10 INFO - 'USER': 'cltbld', 12:40:10 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929', 12:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:10 INFO - '_': '/tools/buildbot/bin/python'} 12:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:10 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)) 12:40:10 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)) 12:40:10 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)) 12:40:10 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)) 12:40:10 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)) 12:40:10 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)) 12:40:10 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)) 12:40:10 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)) 12:40:10 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)) 12:40:10 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)) 12:40:10 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)) 12:40:10 INFO - Cleaning up... 12:40:10 INFO - Return code: 0 12:40:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:40:10 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')]} 12:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:10 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')]} 12:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:10 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 0x7f00cf5a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2417240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a60b0>, '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 0x24a6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a7440>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929', '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 12:40:10 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 12:40:10 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 12:40:10 INFO - Using env: {'DISPLAY': ':0', 12:40:10 INFO - 'HOME': '/home/cltbld', 12:40:10 INFO - 'LANG': 'en_US.UTF-8', 12:40:10 INFO - 'LANGUAGE': 'en_US:en', 12:40:10 INFO - 'LOGNAME': 'cltbld', 12:40:10 INFO - 'MAIL': '/var/mail/cltbld', 12:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:10 INFO - 'MOZ_NO_REMOTE': '1', 12:40:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:10 INFO - 'NO_EM_RESTART': '1', 12:40:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:10 INFO - 'PWD': '/builds/slave/test', 12:40:10 INFO - 'SHELL': '/bin/bash', 12:40:10 INFO - 'SHLVL': '1', 12:40:10 INFO - 'TERM': 'linux', 12:40:10 INFO - 'TMOUT': '86400', 12:40:10 INFO - 'USER': 'cltbld', 12:40:10 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929', 12:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:10 INFO - '_': '/tools/buildbot/bin/python'} 12:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:10 INFO - Downloading/unpacking jsonschema 12:40:10 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 12:40:10 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 12:40:10 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 12:40:10 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 12:40:10 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 12:40:10 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 12:40:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:40:12 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 12:40:12 INFO - Downloading/unpacking functools32 (from jsonschema) 12:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:12 INFO - Downloading functools32-3.2.3-2.tar.gz 12:40:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 12:40:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:40:12 INFO - warning: no files found matching '*.txt' 12:40:12 INFO - no previously-included directories found matching 'build' 12:40:12 INFO - no previously-included directories found matching 'dist' 12:40:12 INFO - no previously-included directories found matching '.git*' 12:40:12 INFO - Installing collected packages: jsonschema, functools32 12:40:12 INFO - Running setup.py install for functools32 12:40:12 INFO - warning: no files found matching '*.txt' 12:40:12 INFO - no previously-included directories found matching 'build' 12:40:12 INFO - no previously-included directories found matching 'dist' 12:40:12 INFO - no previously-included directories found matching '.git*' 12:40:12 INFO - Successfully installed jsonschema functools32 12:40:12 INFO - Cleaning up... 12:40:12 INFO - Return code: 0 12:40:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f00cf5a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2417240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a60b0>, '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 0x24a6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a7440>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929', '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 12:40:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:40:12 INFO - Using env: {'DISPLAY': ':0', 12:40:12 INFO - 'HOME': '/home/cltbld', 12:40:12 INFO - 'LANG': 'en_US.UTF-8', 12:40:12 INFO - 'LANGUAGE': 'en_US:en', 12:40:12 INFO - 'LOGNAME': 'cltbld', 12:40:12 INFO - 'MAIL': '/var/mail/cltbld', 12:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:12 INFO - 'MOZ_NO_REMOTE': '1', 12:40:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:12 INFO - 'NO_EM_RESTART': '1', 12:40:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:12 INFO - 'PWD': '/builds/slave/test', 12:40:12 INFO - 'SHELL': '/bin/bash', 12:40:12 INFO - 'SHLVL': '1', 12:40:12 INFO - 'TERM': 'linux', 12:40:12 INFO - 'TMOUT': '86400', 12:40:12 INFO - 'USER': 'cltbld', 12:40:12 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929', 12:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:12 INFO - '_': '/tools/buildbot/bin/python'} 12:40:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:12 INFO - Downloading/unpacking flake8 12:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:40:14 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 12:40:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:40:14 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 12:40:14 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 12:40:14 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 12:40:14 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 12:40:14 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 12:40:14 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 12:40:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:40:14 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 12:40:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:40:14 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 12:40:14 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 12:40:14 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 12:40:14 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 12:40:14 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 12:40:14 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 12:40:14 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 12:40:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:40:14 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 12:40:14 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 12:40:14 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 12:40:14 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 12:40:14 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 12:40:14 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 12:40:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 12:40:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:40:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:40:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:40:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:40:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:40:15 INFO - no previously-included directories found matching 'docs/_build' 12:40:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:40:15 INFO - Running setup.py install for pep8 12:40:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:40:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:40:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:40:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:40:15 INFO - no previously-included directories found matching 'docs/_build' 12:40:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:40:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:40:15 INFO - Cleaning up... 12:40:15 INFO - Return code: 0 12:40:15 INFO - Running post-action listener: _resource_record_post_action 12:40:15 INFO - Running post-action listener: _start_resource_monitoring 12:40:15 INFO - Starting resource monitoring. 12:40:15 INFO - ##### 12:40:15 INFO - ##### Running install step. 12:40:15 INFO - ##### 12:40:15 INFO - Running pre-action listener: _resource_record_pre_action 12:40:15 INFO - Running main action method: install 12:40:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:40:15 INFO - Reading from file tmpfile_stdout 12:40:15 INFO - Detecting whether we're running mozinstall >=1.0... 12:40:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:40:15 INFO - Reading from file tmpfile_stdout 12:40:15 INFO - Output received: 12:40:15 INFO - Usage: mozinstall [options] installer 12:40:15 INFO - Options: 12:40:15 INFO - -h, --help show this help message and exit 12:40:15 INFO - -d DEST, --destination=DEST 12:40:15 INFO - Directory to install application into. [default: 12:40:15 INFO - "/builds/slave/test"] 12:40:15 INFO - --app=APP Application being installed. [default: firefox] 12:40:15 INFO - mkdir: /builds/slave/test/build/application 12:40:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:40:30 INFO - Reading from file tmpfile_stdout 12:40:30 INFO - Output received: 12:40:30 INFO - /builds/slave/test/build/application/firefox/firefox 12:40:30 INFO - Running post-action listener: _resource_record_post_action 12:40:30 INFO - ##### 12:40:30 INFO - ##### Running run-tests step. 12:40:30 INFO - ##### 12:40:30 INFO - Running pre-action listener: _resource_record_pre_action 12:40:30 INFO - Running main action method: run_tests 12:40:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:40:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:40:30 INFO - Python 2.7.3 12:40:30 INFO - Return code: 0 12:40:30 INFO - grabbing minidump binary from tooltool 12:40: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')]} 12:40:30 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 0x24a60b0>, '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 0x24a6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a7440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:40:30 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 12:40:30 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 12:40:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:40:30 INFO - Return code: 0 12:40:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:40:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:40:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:40:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:40:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:40:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:40:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:40:31 INFO - Return code: 0 12:40:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost'] in /builds/slave/test/build 12:40:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost 12:40:31 INFO - Using env: {'DISPLAY': ':0', 12:40:31 INFO - 'HOME': '/home/cltbld', 12:40:31 INFO - 'LANG': 'en_US.UTF-8', 12:40:31 INFO - 'LANGUAGE': 'en_US:en', 12:40:31 INFO - 'LOGNAME': 'cltbld', 12:40:31 INFO - 'MAIL': '/var/mail/cltbld', 12:40:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:40:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:31 INFO - 'MOZ_NO_REMOTE': '1', 12:40:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:40:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:31 INFO - 'NO_EM_RESTART': '1', 12:40:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:31 INFO - 'PWD': '/builds/slave/test', 12:40:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:40:31 INFO - 'SHELL': '/bin/bash', 12:40:31 INFO - 'SHLVL': '1', 12:40:31 INFO - 'TERM': 'linux', 12:40:31 INFO - 'TMOUT': '86400', 12:40:31 INFO - 'USER': 'cltbld', 12:40:31 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929', 12:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:31 INFO - '_': '/tools/buildbot/bin/python'} 12:40:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost'] with output_timeout 3600 12:40:31 INFO - mozversion INFO | application_buildid: 20151216114502 12:40:31 INFO - mozversion INFO | application_changeset: 2c0d64cea673b90bc49aa8d4cfa63787931782cc 12:40:31 INFO - mozversion INFO | application_display_name: Nightly 12:40:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:40:31 INFO - mozversion INFO | application_name: Firefox 12:40:31 INFO - mozversion INFO | application_remotingname: firefox 12:40:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:40:31 INFO - mozversion INFO | application_vendor: Mozilla 12:40:31 INFO - mozversion INFO | application_version: 46.0a1 12:40:31 INFO - mozversion INFO | platform_buildid: 20151216114502 12:40:31 INFO - mozversion INFO | platform_changeset: 2c0d64cea673b90bc49aa8d4cfa63787931782cc 12:40:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:40:31 INFO - mozversion INFO | platform_version: 46.0a1 12:40:31 INFO - 2015-12-16 12:40:31,552 DEBUG : using testdate: 1450298431 12:40:31 INFO - 2015-12-16 12:40:31,552 DEBUG : actual date: 1450298431 12:40:31 INFO - 2015-12-16 12:40:31,630 INFO : starting webserver on 'localhost:53860' 12:40:31 INFO - 2015-12-16 12:40:31,631 INFO : Starting test suite talos-linux64-ix-054 12:40:31 INFO - 2015-12-16 12:40:31,632 INFO : Starting test dromaeo_css 12:40:31 INFO - 2015-12-16 12:40:31,632 DEBUG : operating with platform_type : linux_ 12:40:31 INFO - 2015-12-16 12:40:31,632 INFO : Initialising browser for dromaeo_css test... 12:40:31 INFO - 2015-12-16 12:40:31,649 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8BPOEm/profile http://localhost:53860/getInfo.html 12:40:36 INFO - 2015-12-16 12:40:36,537 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:40:36 INFO - 2015-12-16 12:40:36,537 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:40:36 INFO - 2015-12-16 12:40:36,537 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:40:36 INFO - 2015-12-16 12:40:36,537 DEBUG : BROWSER_OUTPUT: __metrics 12:40:36 INFO - 2015-12-16 12:40:36,653 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] 12:40:36 INFO - 2015-12-16 12:40:36,717 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:40:36 ERROR - 2015-12-16 12:40:36,733 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 12:40:37 INFO - 2015-12-16 12:40:37,654 INFO : Browser initialized. 12:40:37 INFO - 2015-12-16 12:40:37,655 INFO : Running cycle 1/1 for dromaeo_css test... 12:40:37 INFO - 2015-12-16 12:40:37,655 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8BPOEm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:40:49 INFO - 2015-12-16 12:40:49,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 142966784 12:40:49 INFO - 2015-12-16 12:40:49,679 DEBUG : BROWSER_OUTPUT: 12:41:40 INFO - 2015-12-16 12:41:40,967 DEBUG : BROWSER_OUTPUT: 1450298500964 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] 12:43:52 INFO - 2015-12-16 12:43:52,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53860/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53860/tests/dromaeo/cssquery-ext.html) 12:43:54 INFO - 2015-12-16 12:43:54,071 DEBUG : BROWSER_OUTPUT: RSS: Main: 249925632 12:43:54 INFO - 2015-12-16 12:43:54,071 DEBUG : BROWSER_OUTPUT: 12:46:56 INFO - 2015-12-16 12:46:56,685 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53860/tests/dromaeo/cssquery-ext.html (next: http://localhost:53860/tests/dromaeo/cssquery-jquery.html) 12:46:57 INFO - 2015-12-16 12:46:57,258 DEBUG : BROWSER_OUTPUT: RSS: Main: 225361920 12:46:57 INFO - 2015-12-16 12:46:57,259 DEBUG : BROWSER_OUTPUT: 12:49:59 INFO - 2015-12-16 12:49:59,264 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53860/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53860/tests/dromaeo/cssquery-mootools.html) 12:49:59 INFO - 2015-12-16 12:49:59,838 DEBUG : BROWSER_OUTPUT: RSS: Main: 212922368 12:49:59 INFO - 2015-12-16 12:49:59,838 DEBUG : BROWSER_OUTPUT: 12:53:01 INFO - 2015-12-16 12:53:01,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53860/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53860/tests/dromaeo/cssquery-prototype.html) 12:53:02 INFO - 2015-12-16 12:53:02,350 DEBUG : BROWSER_OUTPUT: RSS: Main: 204541952 12:53:02 INFO - 2015-12-16 12:53:02,350 DEBUG : BROWSER_OUTPUT: 12:56:05 INFO - 2015-12-16 12:56:05,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53860/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53860/tests/dromaeo/cssquery-yui.html) 12:56:05 INFO - 2015-12-16 12:56:05,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 210563072 12:56:05 INFO - 2015-12-16 12:56:05,648 DEBUG : BROWSER_OUTPUT: 12:59:07 INFO - 2015-12-16 12:59:07,950 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53860/tests/dromaeo/cssquery-yui.html (next: http://localhost:53860/tests/dromaeo/cssquery-dojo.html) 12:59:08 INFO - 2015-12-16 12:59:08,208 DEBUG : BROWSER_OUTPUT: RSS: Main: 257077248 12:59:08 INFO - 2015-12-16 12:59:08,208 DEBUG : BROWSER_OUTPUT: 12:59:08 INFO - 2015-12-16 12:59:08,208 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:59:08 INFO - 2015-12-16 12:59:08,208 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:59:08 INFO - 2015-12-16 12:59:08,208 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:59:08 INFO - 2015-12-16 12:59:08,209 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:59:08 INFO - 2015-12-16 12:59:08,209 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2610.843349399036;2709.309126172827;2717.904873329434;2720.687120981088;2725.7955653326;4522.14079324928;4704.106219818232;4754.548317909793;4776.092542416943;4776.4507081685615;4708.929366059512;4712.1518126737255;4771.665983381165;4783.928241076378;4785.234362502;4302.935455968147;4377.584129507692;4400.933985990213;4409.074094440171;4428.047969686517;4241.766702831343;4327.545607711177;4355.237833379162;4419.801108950105;4449.7330160190495;4313.374560688714;4338.501072376685;4398.296272596369;4402.053558484941;4429.42417485728;4344.9128188329105;4359.237133501656;4374.103308821684;4385.166818304512;4432.445944256968;4197.727147735387;4281.743095414286;4336.111097225062;4341.674374421931;4389.692721509496;4555;4570.611498022672;4657;4676.649251306131;4706.129366067288;5088.465711100318;5092.869982025158;5093.414257360377;5095.898082038376;5145.125328694131;4865.489123642002;4981.302617633534;5128.076946149691;5129.666571672867;5139.7687104080405;4634.443866736014;4669.929951050737;4708.4349878014855;4719.504452032487;4756.6908150970075;5166.9224961625605;5169.948300517022;5186.6369354144845;5195.896082078338;5235.73821308933;4788.832390866303;4902.950970490249;4976.328195693607;4984.177610694195;4987.451380348159;4991.575716064102;5038.874028149326;5077.1876499759865;5082.059818933509;5088.389393272757;5014.0974624567925;5045.84862454127;5052.242163675478;5064.46823083571;5081.441041485434;4804.495527969582;4917.532834380728;5003.24951257307;5015.749212539358;5018.42288136869;4139.110091330318;4150.5641907599875;4215.873523794291;4227.6406505447385;4237;3693.2798104369926;3703.7407381483035;3705.7961812100593;3741.2704522618374;3744.363458212056;4352.564743525622;4389.385486031958;4392.3850660906855;4397.824087036547;4434.445694288214;4843.685160464559;4930;4952.083864485082;4956.677815941952;5019.899602007939;4380.123975204971;4382.8904277392685;4383.3863259143745;4387.890302742393;4418.138462999748;4493.438320209973;4496.482904465963;4498.482674492409;4498.572635599613;4536.931946020813;4637.42032245976;4739.146953548395;4753.904921901473;4764.237721964469;4848.272759086165;5060.2156665716875;5075.2387141929;5080.669756465818;5084.211947148198;5100.030994111107;4833.419989601271;4838.685485443435;4839.467658557626;4840.540148685869;4870.756462176806;4804.42346918372;4905.043516514245;4914.0908931847725;4916.729579872998;5054.039732450822;5085.338905942203;5093.108705976365;5117.795288188431;5118.820841270538;5122.026814905156;4937.876553086202;4938.555530002317;4942.456329803646;4946.060248552763;4978.054169707744;4717.457492388419;4829.179039563212;4831.444383895757;4932.30947667334;4993.201087825931;4752.691075080109;4788.712677239377;4817.759112044454;4824.541668541483;4861.076395484846;4879.536444037811;4918.2376731606655;4922;4948.66703493032;4963.255511673278;4655.650826187982;4757.26262429324;4769.236922092448;4830.975665679804;4865.951340486691 12:59:08 INFO - 2015-12-16 12:59:08,209 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.4347530731617;563.4281204577353;570.9000924838152;571.9456651618096;573.6386076771633;26057.088001919936;34627.826860865694;35066.29867402657;35257.47113793295;35352.82323588385;39137.804310978405;39462.40806387906;39473.80263098681;39597.60402395975;39698.60301396985;6995.265497122779;7109.644517774116;7823.374130069595;7984.041914970212;7987.440879138463;10119.241056920724;10375.42935138567;10382.377057376543;10387;10393.428361440117;10019.248556358265;10142.188624910026;10149.644762433316;10149.847752283722;10152.54313555888;6962.512624116314;7106.147262328502;10016.098551130397;10194.898051019543;10443.164546836235;9819.165370943478;9874.111329980264;9933.10602045812;9952.601895924154;9954.651587194414;37060.44409333862;37601.62398376009;37632.43551346732;37643.24713505742;37647;2896.1456370370793;2902.34697193132;3446.603640581315;3643.908902277438;3685.281370132825;27482.45035099287;27648.170554883385;27813.582796258073;28389.85805070982;28765.424691506054;2425.527022230666;3111.673274306188;3254.7721659483846;3318.286568387784;3341.916452088693;150244;150807.24596376947;166877;167023.16488417602;167259;49026;49384.75307623439;49411;49446.50553494491;49526.75236623866;51852;52108.47891521112;52144.73927630338;52180;52246.47753522416;14142.50501232452;14662.340194691264;14667.046641968238;14668.55994320172;14686.339114739649;11117.94379533943;11184.832227516594;11203.94398028021;11211.60759373418;11222.831657525143;17643.55891102707;17703.911480442774;17768.644627107384;17794.288228470716;17837.821621783874;7023.5379665508635;7188.640567971581;7250.3112204340505;7327.230640782747;7327.377172940253;798.7244400681756;803.4215364937236;810.5177419435427;818.1532114261711;835.6657337065222;27091.864540677172;27609.137307368237;27629.723702763116;27743.30641733973;27786.16641500758;709.1596458197052;841.7643059943226;864.2783275964514;887.7114937645161;901.6799036342135;13041.543545975845;14081.08472949255;14187.219702916438;14205.502807401692;14239.715205696035;295675;300245;300798;301005;301016;43909.341359879625;44421;45005.77497112559;45344.54655453469;46671.533284666715;1230.926144431337;1259.1311994723612;1259.1500737002486;1270.764908491932;1271.6058022013206;27065.72934270632;27405.314867127683;28166.85916570404;28232.29419264535;28470.85764571164;35381.64618353886;35835;39542.40686389764;40198;40203.39694904637;165346;166158;166502;166740;166756.16621916814;28555.857220713762;28678.71321286844;28704.856475717486;28909;28959;36964;37914.24171516609;38535.6146438532;38595.421068684554;38729.80635096919;32144.83927580347;32494.35011299808;32716.182095447803;32901.50647740334;33310.66689333076;32465.51301730523;32572.913082718274;32596.674033259365;32749.181270468427;32826.17934551655;32046.83976580102;32500.18749531186;32598.837005814818;32724.509132362557;32757.67242327546;28921.132366029055;29397.706022940354;29933.700662993964;34197.487037694955;35534.46698299476;23619.937102830758;23706.88146559256;23735.643965340187;23847.284581462583;24126.396840078436 12:59:08 INFO - 2015-12-16 12:59:08,209 DEBUG : BROWSER_OUTPUT: |2;jquery.html;339.4263694356537;340.0682130961167;341.88546836809667;342.98113603751784;347.3417873130418;12466.812997805018;12885.613431597067;14760.557183284505;14835.703285934274;15561.688766224683;12772.744545109115;14873.851261487382;15818.683626327494;16170.595735106599;16193.352265909349;4853.077915196111;4859.173940430118;5018.172001619747;5019.071471777733;5033.773480193382;3720.869769558066;3849.056981039635;4990.426100998396;5014.997000599877;5546;5668.829935101933;5695.202671625976;5715.171300161474;5721;5721.713914304289;5282.683039017671;5285.86785330366;5288.762005709752;5430.15832545956;5684.147377893308;4944.777485013183;5067.442581316089;5078.695278283315;5079.847604571869;5085.0338435697095;18985;19295.614087718306;19492.902535487232;19707;19722.309719159904;1858.5725283184809;1882.7081802320663;1882.7834798998153;1979.4556496963307;2035.328341647253;8040.758777236692;8125.959370203112;8233.17668233178;8323.750287491384;8356.874646880302;1744.7034004219313;1747.790265168188;1780.5726625609761;1826.9086545672662;1836.164545131975;51796.741016295055;54060.45939540594;54237.45762542403;54329.456705432836;54958.72520637371;9817.656382026595;9834.262430317754;9873.555689993967;9881.209503239723;9943.850842237372;12566.623001309976;12576.11967162308;12580.308083055337;12583.559575414816;12586;7210.423166146696;7283.781486555412;7284.963575182091;7341.082364704412;7352.889706654404;7018.297740513868;7036.401905838061;7083.574985500886;7096.361327480448;7109.253528379446;4150.896227594274;4171.353440216772;4194.475690538683;4195.391668208093;4229.154169166179;1607.1401800036924;1640.6554623528955;1691.6109294862251;1709.2821015173656;1713.4859542137308;838.3795990966763;849.8470275350372;858.9484630922165;876.7895705030875;1004.57305645102;15316.387344506094;15395.677745048388;15644.608884777972;15844.207789610473;16263.268152933146;725.7278520554792;799.9880001799978;881.0308660473428;895.136193573205;948.3361646847235;8541.27399171065;8628.96452425713;8704.564771761387;8914.28685705142;9257.49083800384;496293.2335696309;504739.66822322085;506487;516701;519455;68431.65784171048;70452.64773676201;72080.27919720841;72636;72984;1047.4239168457318;1102.6691992402248;1106.7952428800697;1114.3926560024806;1115.3865374044244;14356;14428.711425771216;14472.710545788814;14560.126392416489;14637.487687930872;33248.335033299685;33366.83316583402;33827.58758598711;33896.49155262722;33959.75503062117;42339;42917.57082429136;44446.333304999804;45034.87412814706;45298.508582028306;8087.676492940216;8304.169583041648;8328.292095171979;8329;8750.956245218733;10212.387256764618;10221.131203847459;10229.488525573543;10317.793644126925;10786.514606842868;13299.534516291884;13317.134386264861;13483.056186067273;13526.93236533811;13667.658308542366;12962;13153.736925261632;13193.274369909746;13502.797458037941;13606.52377166834;14325.355359009078;14552.708945821236;14603.415863365772;14623;14856.851431485979;9209.125133112344;9236.584353703965;9264.861027084735;9269.582868771056;9317.39436936597;12967;13466.596002119952;13512.189268643913;13727.588172354845;13923.4430622778 12:59:08 INFO - 2015-12-16 12:59:08,209 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1263.5261776833688;1419.3967563785388;1422.3954819201836;1650.331615695643;1710.3842616658005;6015.578909476333;7066.2580429054915;7270.054892863934;7271.963640181805;7292.890606640898;7126.643667816615;7251.238619944909;7267.30960558746;7269.418446524279;7286.744963926264;1746.4673274651227;1767.9558011049699;2069.844761642883;2079.4593405714472;2112.915483380663;2106.947326316839;2109.820665243456;2119.7138386317806;2121.9257325993594;2126.797954194349;2026.7466566679166;2046.4679183412345;2068.9275875344365;2069.4515953272394;2070.3581889614193;2050.1389416445127;2059.166037754704;2074.284371891695;2119.247667078188;2119.4171602809274;2112.112912576706;2125.7130287411155;2134.6691262854283;2135.4234356723755;2136.7115439415634;7183.92816071843;7262.237465066198;7265.019222404961;7267.745628903016;7277.053982982231;4165.97917010416;4184.958150418487;4206.642435392995;4206.663466922639;4215.114825886537;2654.9336266593295;2673.42521357909;2705.7700095491905;2711.2544050386105;2715.701272859984;820.5897051474263;827.1686954610578;833.9624716887755;853.1809462915609;854.3165467625937;9857.309988300893;9919.553620087114;9920.603175872957;9935.950320248352;9953.452560109192;3987.6809855211513;4007.6192761687594;4050.7569545827346;4051.513818341818;4054.9189016220103;8455.957720211483;8481.787955301166;8503.319734421231;8519.914800851911;8527.317814574819;4322.7190232634775;4339.956600433955;4345.630621397154;4347.934780978288;4348.28253338202;3937.940930886039;3942.3495123304906;3945.072907866649;3945.8027098644952;3947.5657677655436;3051.4354844353866;3086.058752080637;3115.9221019474694;3142.3244002539564;3511.1924257420424;1116.3580940958982;1121.6803211084803;1123.3260043973714;1123.5056575106926;1127.3968426891574;912.9954350228339;917.9265658747285;935.5976929920199;987.2940847294219;1138.7779383020231;6843.726250949906;6897.586144831226;6920.9653951729915;6921.446284297244;6923.5460553283365;1050.5115121468555;1124.3029321820525;1135.7047167736448;1150.730788773659;1161.6108603617713;5052.368453943257;5074.797008119708;5091.770870310771;5099.490050994871;5102.617303702163;8648.740537783877;8677;8683.435576687496;8809.955950220208;8901.465912045298;8645.481271123752;8706.564671766386;8706.825863482694;8714.041455439896;8714.694985675598;6744.595324280559;6814.284500127515;6853.383195512328;6887.070245516791;6899.793006209822;6591.307912669293;6599.505037122139;6629.7679581214425;6630;6636.502262330441;7460.7015719372785;7706.152323244551;7752.961235193788;7792.493487923267;7794.922050779646;7886.093099293655;7894.644740986554;7977.680892764457;8111.594420279081;8120.878186827321;6495.577787443801;6562.901556476561;6565.244996825426;6580.374864387875;6581.210254769267;6291.087792270004;6300.243970723543;6345.873082538231;6372.107904893226;6984.511084224258;6283.528735344776;6387.616742995435;6399.712012959521;6509.902351464637;6588.769393071219;6185.969070154621;6202.596831205957;6241.282252541016;6278.46633036197;6283.528735344776;6430.3891130342545;6589.4069533742195;6592.43964263043;6597.60414375139;6609.339066093352;6003.0695242237525;6030.095485677008;6031.24609423822;6034.969825150846;6035.064564992434;5945.970270148795;6009.489193418608;6011.128386384037;6065.423784740443;6100.603460775035 12:59:08 INFO - 2015-12-16 12:59:08,209 DEBUG : BROWSER_OUTPUT: |4;prototype.html;299.9475091858925;303.57044781633994;303.64018637914074;310.6117353308366;311.1350445760783;5339.145736682131;5339.919901201481;5357.571394288462;5375.516203541681;5396.541293990015;5092.79628814847;5169.3279873616375;5228.816991405301;5299.894002119955;5346.91979620305;4129.690273229505;4154.85458008969;4164.791760411982;4172.395002724603;4174.039970806716;3949.486566746333;4148.253314403406;4159.334506478964;4164.916701665965;4172.18642364739;4020.517537895457;4028.7179897407195;4127.8968025799295;4143.803783994488;4148;4124.278251306009;4126.504819421673;4135.35901935199;4135.627793498599;4137.606927341898;3655.8354874030733;3660.2313514162056;3661.1030297577;3665.981670091659;3667.2848794485085;5123.1546794778815;5133.204353325241;5136.8202112925865;5146.073706732786;5149.201873709581;4526.93209601853;4678.578927896471;4695.201815691306;4697.530246975275;4761.571458568711;5547.417521160261;5554.472325129106;5566.916496252559;5567.693776842272;5573.247611572427;3852.171783066626;3855.8264878080554;3857.9807100964595;3861.826217820205;3865.632764887331;5791.3629500755305;5866.354700982888;5870.706464676749;5874.030784920483;5874.676892770896;3899.122697393064;4010.979945100256;4012.6990475713856;4023.295923213426;4033.253848038122;4076.1236334188293;4079.0618157823274;4082.3672330788777;4084.0606660467665;4085.4688890444054;4660.930086048712;4670.859874203779;4673.130747700879;4680.040591678698;4680.063987202505;5571.526420254324;5578.832635020955;5585.5531557476115;5586.469285417878;5589.217509548666;1400.4328247059957;1415.7451658701327;1415.9882950204803;1428.435767871685;1445.197915157077;947.8767760191131;948.4783369146942;952.8046750416148;955.0783493928393;956.0582825916466;4921.680090794087;4932.827351042696;4934.6545741798445;4936.062148191832;4939.135651261015;5803.448672376202;5808.273965754281;5810.622309549865;5812.651240925558;5815.88368232633;4767.809287628456;4853;4853.830115945925;4923.48303428142;4991.425986011655;3119.6256449225784;3122.953155702666;3142.214446388403;3146.0719087869134;3159.77881548294;5492.917606235909;5546.86132846674;5554.527865131509;5557.888842223133;5561.972190139104;5851.531877449794;6000.369961154103;6004.669743164168;6006.579539432285;6006.879862402815;5558.055130627803;5559.416261292506;5560.082586373203;5560.360558535739;5561.610687251934;5842.065269556851;5850.12248162779;5855.502282305882;5857.384974577608;5863.413658634103;5700.942990570041;5713.428657134254;5715.199872017838;5715.457031581993;5724.8282551523525;5362.65142765719;5543.279373681396;5548.916766248429;5562.610617256753;5571.777128914798;3953.288408086572;3987.5613682494322;3989.082511022423;3994.0813612869783;3995.220931918248;5817.5345972321265;5841.386654401226;5843.912341314799;5848.327442344185;5852.853678658068;5424.728763561727;5575.665460072409;5583.916241256466;5589.469000444951;5596.440355964533;5618.831435056954;5620.9156862647915;5621.550275977994;5623.3533143689;5634.605577609528;5492.176173573996;5498.285222920995;5499.835004949858;5502.724863756876;5514.834554963358;5641.661500309994;5659.094544872801;5660.320761508646;5664.603477756517;5665.206871037975;5388.946110538845;5510.063289240758;5510.8071217507195;5517.889642207214;5520.834374968757 12:59:08 INFO - 2015-12-16 12:59:08,209 DEBUG : BROWSER_OUTPUT: |5;yui.html;643.7682434323644;689.3416786968446;727.5198369076411;758.4614923404382;776.0028363552835;11716.238444501101;11847.585334513295;11924.940375298122;11927.403629818518;11944.22362546435;11432.37121958292;11481.425928703553;11522.884771152287;11529.884701152985;11544.307341559512;628.7233617208436;630.8139098965817;638.4317957018258;639.6961443314411;802.6588699802561;793.769806756043;803.5660743198665;809.7854068671807;811.1928631012122;811.4765975945512;852.1606217875387;861.8190180062163;862.0388267082221;862.3187681731456;862.7498025572577;661.3849120318126;670.2359310386188;833.6498670558381;853.3940901959554;857.8455877941968;631.09753053134;631.255118959632;632.8512799492115;633.4615576759763;633.6039975015615;11260.155488338325;11299.378534180616;11317.886821131766;11328.26366286197;11344.943275283653;10718.624848130356;10884.891151088466;11066.170037247159;11104.61133860319;11304.660860174208;9542.713718588384;9558.95220523893;9627.374220675703;9671.613135474572;9704.854427183598;3212.16483714236;3232.4343239933155;3250.902472925816;3257.5113732940013;3278.606567211926;37842.81078594617;38339;38345.61654383476;38520.614793851986;38552.22895542073;9028.09719028092;9133.81732365349;9245.537723113817;9287.349885508085;9324;16038.679226415406;16082;16095.356185752438;16108.516744497683;16166.919165404097;6096.29892562361;6269.7492100316385;6276.686165691697;6309.526785491106;6317.684115794192;3502.2120022994623;3518.5601799775027;3530.435130379127;3547.1486843157973;3581.71346292296;2465.7287698353166;2535.404180017731;2536.720960694322;2539.7206307306183;2540.7078186008844;452.6763364194551;455.4762023672803;461.2757969987088;467.68197625614226;470.1419908666697;473.673165515793;592.4904582059426;605.4581149870929;612.9570930034944;616.8642898562309;7861.764147075597;8836.293096552261;8939.776505587282;9006.954965225132;9054.366194366463;450.6957803482636;453.3222831866315;579.458206576852;634.6636282770139;656.2158220926043;3847.826847791856;3875.9806200968815;3889.805509724559;3901.395283731026;3974.002409387716;48073.519264807604;49027.75486122618;49146.508534914195;49151;49449.75275123673;42996.57003429988;43813.34279985803;43908.341374879405;44041.339379909325;44300.556994430284;40727.18545629071;41192.79403603023;41280;41652.37521437181;41842.58157418448;7547;7623.123340815877;7663.27198916102;7686.884696729442;7797.883031754414;30111.397772044875;30421.39157216799;30548.236294092825;30861;30883.69116308898;35526.822365888;38833;39316.213675725754;39498.48275034587;39541.2091758169;9335;9803.313768036169;9811.558479868565;9839.508024598885;9914.752131196778;10227.335223210468;10313.9484302581;10382.42896640692;10398.168146548409;10424.113950314308;9493.952530237304;9515.143637072697;9538.856917146388;9556.61773529051;9611.327207095715;9670.129688328085;9676;9703.66037188695;9748.415095094317;9754.658586949423;9832.213422926006;9943.751406214613;9970.202383809423;9999.20006399501;10025.849612255675;8679.739607811776;8752.34357423183;8786.780330491789;8835.116488351114;8968.910310896808;8354.832903342021;8588.098249683693;8626.482411055105;8739.912600874164;8926.375153739436 12:59:08 INFO - 2015-12-16 12:59:08,210 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:59:08 INFO - 2015-12-16 12:59:08,210 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:59:08 INFO - 2015-12-16 12:59:08,210 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,876 12:59:08 INFO - 2015-12-16 12:59:08,210 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:59:08 INFO - 2015-12-16 12:59:08,210 DEBUG : BROWSER_OUTPUT: __startTimestamp1450299548201__endTimestamp 12:59:08 INFO - 2015-12-16 12:59:08,210 DEBUG : BROWSER_OUTPUT: 12:59:08 INFO - 2015-12-16 12:59:08,210 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:59:08 INFO - 2015-12-16 12:59:08,210 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:59:08 INFO - 2015-12-16 12:59:08,211 DEBUG : BROWSER_OUTPUT: 12:59:08 INFO - 2015-12-16 12:59:08,211 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4660.16 Median:4783.93 stddev:480.52 (10.0%) stddev-sans-first:454.30 12:59:08 INFO - 2015-12-16 12:59:08,211 DEBUG : BROWSER_OUTPUT: Values: 2610.8 2709.3 2717.9 2720.7 2725.8 4522.1 4704.1 4754.5 4776.1 4776.5 4708.9 4712.2 4771.7 4783.9 4785.2 4302.9 4377.6 4400.9 4409.1 4428.0 4241.8 4327.5 4355.2 4419.8 4449.7 4313.4 4338.5 4398.3 4402.1 4429.4 4344.9 4359.2 4374.1 4385.2 4432.4 4197.7 4281.7 4336.1 4341.7 4389.7 4555.0 4570.6 4657.0 4676.6 4706.1 5088.5 5092.9 5093.4 5095.9 5145.1 4865.5 4981.3 5128.1 5129.7 5139.8 4634.4 4669.9 4708.4 4719.5 4756.7 5166.9 5169.9 5186.6 5195.9 5235.7 4788.8 4903.0 4976.3 4984.2 4987.5 4991.6 5038.9 5077.2 5082.1 5088.4 5014.1 5045.8 5052.2 5064.5 5081.4 4804.5 4917.5 5003.2 5015.7 5018.4 4139.1 4150.6 4215.9 4227.6 4237.0 3693.3 3703.7 3705.8 3741.3 3744.4 4352.6 4389.4 4392.4 4397.8 4434.4 4843.7 4930.0 4952.1 4956.7 5019.9 4380.1 4382.9 4383.4 4387.9 4418.1 4493.4 4496.5 4498.5 4498.6 4536.9 4637.4 4739.1 4753.9 4764.2 4848.3 5060.2 5075.2 5080.7 5084.2 5100.0 4833.4 4838.7 4839.5 4840.5 4870.8 4804.4 4905.0 4914.1 4916.7 5054.0 5085.3 5093.1 5117.8 5118.8 5122.0 4937.9 4938.6 4942.5 4946.1 4978.1 4717.5 4829.2 4831.4 4932.3 4993.2 4752.7 4788.7 4817.8 4824.5 4861.1 4879.5 4918.2 4922.0 4948.7 4963.3 4655.7 4757.3 4769.2 4831.0 4866.0 12:59:08 INFO - 2015-12-16 12:59:08,211 DEBUG : BROWSER_OUTPUT: 12:59:08 INFO - 2015-12-16 12:59:08,211 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37406.27 Median:17877.48 stddev:57026.64 (319.0%) stddev-sans-first:57119.51 12:59:08 INFO - 2015-12-16 12:59:08,212 DEBUG : BROWSER_OUTPUT: Values: 562.4 563.4 570.9 571.9 573.6 26057.1 34627.8 35066.3 35257.5 35352.8 39137.8 39462.4 39473.8 39597.6 39698.6 6995.3 7109.6 7823.4 7984.0 7987.4 10119.2 10375.4 10382.4 10387.0 10393.4 10019.2 10142.2 10149.6 10149.8 10152.5 6962.5 7106.1 10016.1 10194.9 10443.2 9819.2 9874.1 9933.1 9952.6 9954.7 37060.4 37601.6 37632.4 37643.2 37647.0 2896.1 2902.3 3446.6 3643.9 3685.3 27482.5 27648.2 27813.6 28389.9 28765.4 2425.5 3111.7 3254.8 3318.3 3341.9 150244.0 150807.2 166877.0 167023.2 167259.0 49026.0 49384.8 49411.0 49446.5 49526.8 51852.0 52108.5 52144.7 52180.0 52246.5 14142.5 14662.3 14667.0 14668.6 14686.3 11117.9 11184.8 11203.9 11211.6 11222.8 17643.6 17703.9 17768.6 17794.3 17837.8 7023.5 7188.6 7250.3 7327.2 7327.4 798.7 803.4 810.5 818.2 835.7 27091.9 27609.1 27629.7 27743.3 27786.2 709.2 841.8 864.3 887.7 901.7 13041.5 14081.1 14187.2 14205.5 14239.7 295675.0 300245.0 300798.0 301005.0 301016.0 43909.3 44421.0 45005.8 45344.5 46671.5 1230.9 1259.1 1259.2 1270.8 1271.6 27065.7 27405.3 28166.9 28232.3 28470.9 35381.6 35835.0 39542.4 40198.0 40203.4 165346.0 166158.0 166502.0 166740.0 166756.2 28555.9 28678.7 28704.9 28909.0 28959.0 36964.0 37914.2 38535.6 38595.4 38729.8 32144.8 32494.4 32716.2 32901.5 33310.7 32465.5 32572.9 32596.7 32749.2 32826.2 32046.8 32500.2 32598.8 32724.5 32757.7 28921.1 29397.7 29933.7 34197.5 35534.5 23619.9 23706.9 23735.6 23847.3 24126.4 12:59:08 INFO - 2015-12-16 12:59:08,212 DEBUG : BROWSER_OUTPUT: 12:59:08 INFO - 2015-12-16 12:59:08,212 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26823.18 Median:4194.93 stddev:83062.10 (1980.1%) stddev-sans-first:83271.30 12:59:08 INFO - 2015-12-16 12:59:08,212 DEBUG : BROWSER_OUTPUT: Values: 339.4 340.1 341.9 343.0 347.3 12466.8 12885.6 14760.6 14835.7 15561.7 12772.7 14873.9 15818.7 16170.6 16193.4 4853.1 4859.2 5018.2 5019.1 5033.8 3720.9 3849.1 4990.4 5015.0 5546.0 5668.8 5695.2 5715.2 5721.0 5721.7 5282.7 5285.9 5288.8 5430.2 5684.1 4944.8 5067.4 5078.7 5079.8 5085.0 18985.0 19295.6 19492.9 19707.0 19722.3 1858.6 1882.7 1882.8 1979.5 2035.3 8040.8 8126.0 8233.2 8323.8 8356.9 1744.7 1747.8 1780.6 1826.9 1836.2 51796.7 54060.5 54237.5 54329.5 54958.7 9817.7 9834.3 9873.6 9881.2 9943.9 12566.6 12576.1 12580.3 12583.6 12586.0 7210.4 7283.8 7285.0 7341.1 7352.9 7018.3 7036.4 7083.6 7096.4 7109.3 4150.9 4171.4 4194.5 4195.4 4229.2 1607.1 1640.7 1691.6 1709.3 1713.5 838.4 849.8 858.9 876.8 1004.6 15316.4 15395.7 15644.6 15844.2 16263.3 725.7 800.0 881.0 895.1 948.3 8541.3 8629.0 8704.6 8914.3 9257.5 496293.2 504739.7 506487.0 516701.0 519455.0 68431.7 70452.6 72080.3 72636.0 72984.0 1047.4 1102.7 1106.8 1114.4 1115.4 14356.0 14428.7 14472.7 14560.1 14637.5 33248.3 33366.8 33827.6 33896.5 33959.8 42339.0 42917.6 44446.3 45034.9 45298.5 8087.7 8304.2 8328.3 8329.0 8751.0 10212.4 10221.1 10229.5 10317.8 10786.5 13299.5 13317.1 13483.1 13526.9 13667.7 12962.0 13153.7 13193.3 13502.8 13606.5 14325.4 14552.7 14603.4 14623.0 14856.9 9209.1 9236.6 9264.9 9269.6 9317.4 12967.0 13466.6 13512.2 13727.6 13923.4 12:59:08 INFO - 2015-12-16 12:59:08,212 DEBUG : BROWSER_OUTPUT: 12:59:08 INFO - 2015-12-16 12:59:08,212 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5029.52 Median:6281.00 stddev:2630.82 (41.9%) stddev-sans-first:2622.97 12:59:08 INFO - 2015-12-16 12:59:08,213 DEBUG : BROWSER_OUTPUT: Values: 1263.5 1419.4 1422.4 1650.3 1710.4 6015.6 7066.3 7270.1 7272.0 7292.9 7126.6 7251.2 7267.3 7269.4 7286.7 1746.5 1768.0 2069.8 2079.5 2112.9 2106.9 2109.8 2119.7 2121.9 2126.8 2026.7 2046.5 2068.9 2069.5 2070.4 2050.1 2059.2 2074.3 2119.2 2119.4 2112.1 2125.7 2134.7 2135.4 2136.7 7183.9 7262.2 7265.0 7267.7 7277.1 4166.0 4185.0 4206.6 4206.7 4215.1 2654.9 2673.4 2705.8 2711.3 2715.7 820.6 827.2 834.0 853.2 854.3 9857.3 9919.6 9920.6 9936.0 9953.5 3987.7 4007.6 4050.8 4051.5 4054.9 8456.0 8481.8 8503.3 8519.9 8527.3 4322.7 4340.0 4345.6 4347.9 4348.3 3937.9 3942.3 3945.1 3945.8 3947.6 3051.4 3086.1 3115.9 3142.3 3511.2 1116.4 1121.7 1123.3 1123.5 1127.4 913.0 917.9 935.6 987.3 1138.8 6843.7 6897.6 6921.0 6921.4 6923.5 1050.5 1124.3 1135.7 1150.7 1161.6 5052.4 5074.8 5091.8 5099.5 5102.6 8648.7 8677.0 8683.4 8810.0 8901.5 8645.5 8706.6 8706.8 8714.0 8714.7 6744.6 6814.3 6853.4 6887.1 6899.8 6591.3 6599.5 6629.8 6630.0 6636.5 7460.7 7706.2 7753.0 7792.5 7794.9 7886.1 7894.6 7977.7 8111.6 8120.9 6495.6 6562.9 6565.2 6580.4 6581.2 6291.1 6300.2 6345.9 6372.1 6984.5 6283.5 6387.6 6399.7 6509.9 6588.8 6186.0 6202.6 6241.3 6278.5 6283.5 6430.4 6589.4 6592.4 6597.6 6609.3 6003.1 6030.1 6031.2 6035.0 6035.1 5946.0 6009.5 6011.1 6065.4 6100.6 12:59:08 INFO - 2015-12-16 12:59:08,214 DEBUG : BROWSER_OUTPUT: 12:59:08 INFO - 2015-12-16 12:59:08,214 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4650.71 Median:5343.42 stddev:1370.71 (25.7%) stddev-sans-first:1335.09 12:59:08 INFO - 2015-12-16 12:59:08,214 DEBUG : BROWSER_OUTPUT: Values: 299.9 303.6 303.6 310.6 311.1 5339.1 5339.9 5357.6 5375.5 5396.5 5092.8 5169.3 5228.8 5299.9 5346.9 4129.7 4154.9 4164.8 4172.4 4174.0 3949.5 4148.3 4159.3 4164.9 4172.2 4020.5 4028.7 4127.9 4143.8 4148.0 4124.3 4126.5 4135.4 4135.6 4137.6 3655.8 3660.2 3661.1 3666.0 3667.3 5123.2 5133.2 5136.8 5146.1 5149.2 4526.9 4678.6 4695.2 4697.5 4761.6 5547.4 5554.5 5566.9 5567.7 5573.2 3852.2 3855.8 3858.0 3861.8 3865.6 5791.4 5866.4 5870.7 5874.0 5874.7 3899.1 4011.0 4012.7 4023.3 4033.3 4076.1 4079.1 4082.4 4084.1 4085.5 4660.9 4670.9 4673.1 4680.0 4680.1 5571.5 5578.8 5585.6 5586.5 5589.2 1400.4 1415.7 1416.0 1428.4 1445.2 947.9 948.5 952.8 955.1 956.1 4921.7 4932.8 4934.7 4936.1 4939.1 5803.4 5808.3 5810.6 5812.7 5815.9 4767.8 4853.0 4853.8 4923.5 4991.4 3119.6 3123.0 3142.2 3146.1 3159.8 5492.9 5546.9 5554.5 5557.9 5562.0 5851.5 6000.4 6004.7 6006.6 6006.9 5558.1 5559.4 5560.1 5560.4 5561.6 5842.1 5850.1 5855.5 5857.4 5863.4 5700.9 5713.4 5715.2 5715.5 5724.8 5362.7 5543.3 5548.9 5562.6 5571.8 3953.3 3987.6 3989.1 3994.1 3995.2 5817.5 5841.4 5843.9 5848.3 5852.9 5424.7 5575.7 5583.9 5589.5 5596.4 5618.8 5620.9 5621.6 5623.4 5634.6 5492.2 5498.3 5499.8 5502.7 5514.8 5641.7 5659.1 5660.3 5664.6 5665.2 5388.9 5510.1 5510.8 5517.9 5520.8 12:59:08 INFO - 2015-12-16 12:59:08,214 DEBUG : BROWSER_OUTPUT: 12:59:08 INFO - 2015-12-16 12:59:08,214 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11967.81 Median:598.97 stddev:13559.95 (2263.9%) stddev-sans-first:13571.32 12:59:08 INFO - 2015-12-16 12:59:08,214 DEBUG : BROWSER_OUTPUT: Values: 643.8 689.3 727.5 758.5 776.0 11716.2 11847.6 11924.9 11927.4 11944.2 11432.4 11481.4 11522.9 11529.9 11544.3 628.7 630.8 638.4 639.7 802.7 793.8 803.6 809.8 811.2 811.5 852.2 861.8 862.0 862.3 862.7 661.4 670.2 833.6 853.4 857.8 631.1 631.3 632.9 633.5 633.6 11260.2 11299.4 11317.9 11328.3 11344.9 10718.6 10884.9 11066.2 11104.6 11304.7 9542.7 9559.0 9627.4 9671.6 9704.9 3212.2 3232.4 3250.9 3257.5 3278.6 37842.8 38339.0 38345.6 38520.6 38552.2 9028.1 9133.8 9245.5 9287.3 9324.0 16038.7 16082.0 16095.4 16108.5 16166.9 6096.3 6269.7 6276.7 6309.5 6317.7 3502.2 3518.6 3530.4 3547.1 3581.7 2465.7 2535.4 2536.7 2539.7 2540.7 452.7 455.5 461.3 467.7 470.1 473.7 592.5 605.5 613.0 616.9 7861.8 8836.3 8939.8 9007.0 9054.4 450.7 453.3 579.5 634.7 656.2 3847.8 3876.0 3889.8 3901.4 3974.0 48073.5 49027.8 49146.5 49151.0 49449.8 42996.6 43813.3 43908.3 44041.3 44300.6 40727.2 41192.8 41280.0 41652.4 41842.6 7547.0 7623.1 7663.3 7686.9 7797.9 30111.4 30421.4 30548.2 30861.0 30883.7 35526.8 38833.0 39316.2 39498.5 39541.2 9335.0 9803.3 9811.6 9839.5 9914.8 10227.3 10313.9 10382.4 10398.2 10424.1 9494.0 9515.1 9538.9 9556.6 9611.3 9670.1 9676.0 9703.7 9748.4 9754.7 9832.2 9943.8 9970.2 9999.2 10025.8 8679.7 8752.3 8786.8 8835.1 8968.9 8354.8 8588.1 8626.5 8739.9 8926.4 12:59:08 INFO - 2015-12-16 12:59:08,214 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:59:08 INFO - 2015-12-16 12:59:08,214 DEBUG : BROWSER_OUTPUT: 12:59:08 INFO - 2015-12-16 12:59:08,965 INFO : Browser exited with error code: 0 12:59:08 INFO - 2015-12-16 12:59:08,986 INFO : Completed test dromaeo_css (00:18:37) 12:59:08 INFO - 2015-12-16 12:59:08,987 INFO : Starting test kraken 12:59:08 INFO - 2015-12-16 12:59:08,987 DEBUG : operating with platform_type : linux_ 12:59:08 INFO - 2015-12-16 12:59:08,987 INFO : Initialising browser for kraken test... 12:59:08 INFO - 2015-12-16 12:59:08,993 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbFafEo/profile http://localhost:53860/getInfo.html 12:59:13 INFO - 2015-12-16 12:59:13,453 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:59:13 INFO - 2015-12-16 12:59:13,453 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:59:13 INFO - 2015-12-16 12:59:13,453 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:59:13 INFO - 2015-12-16 12:59:13,453 DEBUG : BROWSER_OUTPUT: __metrics 12:59:13 INFO - 2015-12-16 12:59:13,554 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] 12:59:13 INFO - 2015-12-16 12:59:13,622 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:59:14 INFO - 2015-12-16 12:59:14,864 INFO : Browser initialized. 12:59:14 INFO - 2015-12-16 12:59:14,865 INFO : Running cycle 1/1 for kraken test... 12:59:14 INFO - 2015-12-16 12:59:14,865 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbFafEo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:59:26 INFO - 2015-12-16 12:59:26,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 142905344 12:59:26 INFO - 2015-12-16 12:59:26,886 DEBUG : BROWSER_OUTPUT: 12:59:29 INFO - 2015-12-16 12:59:29,480 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53860/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53860/tests/kraken/driver.html?testName=audio-beat-detection) 12:59:30 INFO - 2015-12-16 12:59:30,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 175984640 12:59:30 INFO - 2015-12-16 12:59:30,062 DEBUG : BROWSER_OUTPUT: 12:59:32 INFO - 2015-12-16 12:59:32,791 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53860/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53860/tests/kraken/driver.html?testName=audio-dft) 12:59:33 INFO - 2015-12-16 12:59:33,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 165859328 12:59:33 INFO - 2015-12-16 12:59:33,372 DEBUG : BROWSER_OUTPUT: 12:59:36 INFO - 2015-12-16 12:59:36,372 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53860/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53860/tests/kraken/driver.html?testName=audio-fft) 12:59:36 INFO - 2015-12-16 12:59:36,933 DEBUG : BROWSER_OUTPUT: RSS: Main: 154030080 12:59:36 INFO - 2015-12-16 12:59:36,933 DEBUG : BROWSER_OUTPUT: 12:59:38 INFO - 2015-12-16 12:59:38,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53860/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53860/tests/kraken/driver.html?testName=audio-oscillator) 12:59:39 INFO - 2015-12-16 12:59:39,539 DEBUG : BROWSER_OUTPUT: RSS: Main: 155271168 12:59:39 INFO - 2015-12-16 12:59:39,539 DEBUG : BROWSER_OUTPUT: 12:59:41 INFO - 2015-12-16 12:59:41,819 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53860/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53860/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:59:42 INFO - 2015-12-16 12:59:42,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 157450240 12:59:42 INFO - 2015-12-16 12:59:42,384 DEBUG : BROWSER_OUTPUT: 12:59:45 INFO - 2015-12-16 12:59:45,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53860/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53860/tests/kraken/driver.html?testName=imaging-darkroom) 12:59:45 INFO - 2015-12-16 12:59:45,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 156753920 12:59:45 INFO - 2015-12-16 12:59:45,955 DEBUG : BROWSER_OUTPUT: 12:59:49 INFO - 2015-12-16 12:59:49,383 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53860/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53860/tests/kraken/driver.html?testName=imaging-desaturate) 12:59:49 INFO - 2015-12-16 12:59:49,956 DEBUG : BROWSER_OUTPUT: RSS: Main: 159780864 12:59:49 INFO - 2015-12-16 12:59:49,956 DEBUG : BROWSER_OUTPUT: 12:59:52 INFO - 2015-12-16 12:59:52,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53860/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53860/tests/kraken/driver.html?testName=json-parse-financial) 12:59:53 INFO - 2015-12-16 12:59:53,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 157446144 12:59:53 INFO - 2015-12-16 12:59:53,335 DEBUG : BROWSER_OUTPUT: 12:59:55 INFO - 2015-12-16 12:59:55,109 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53860/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53860/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:59:55 INFO - 2015-12-16 12:59:55,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 167489536 12:59:55 INFO - 2015-12-16 12:59:55,670 DEBUG : BROWSER_OUTPUT: 12:59:57 INFO - 2015-12-16 12:59:57,567 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53860/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53860/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:59:58 INFO - 2015-12-16 12:59:58,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 166768640 12:59:58 INFO - 2015-12-16 12:59:58,170 DEBUG : BROWSER_OUTPUT: 13:00:00 INFO - 2015-12-16 13:00:00,287 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53860/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53860/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:00:00 INFO - 2015-12-16 13:00:00,868 DEBUG : BROWSER_OUTPUT: RSS: Main: 177307648 13:00:00 INFO - 2015-12-16 13:00:00,868 DEBUG : BROWSER_OUTPUT: 13:00:03 INFO - 2015-12-16 13:00:03,409 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53860/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:00:03 INFO - 2015-12-16 13:00:03,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 184971264 13:00:03 INFO - 2015-12-16 13:00:03,995 DEBUG : BROWSER_OUTPUT: 13:00:06 INFO - 2015-12-16 13:00:06,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:00:07 INFO - 2015-12-16 13:00:07,184 DEBUG : BROWSER_OUTPUT: RSS: Main: 182616064 13:00:07 INFO - 2015-12-16 13:00:07,184 DEBUG : BROWSER_OUTPUT: 13:00:08 INFO - 2015-12-16 13:00:08,955 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53860/tests/kraken/driver.html?testName=ai-astar) 13:00:09 INFO - 2015-12-16 13:00:09,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 240209920 13:00:09 INFO - 2015-12-16 13:00:09,205 DEBUG : BROWSER_OUTPUT: 13:00:09 INFO - 2015-12-16 13:00:09,206 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:00:09 INFO - 2015-12-16 13:00:09,206 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:00:09 INFO - 2015-12-16 13:00:09,207 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:00:09 INFO - 2015-12-16 13:00:09,207 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:00:09 INFO - 2015-12-16 13:00:09,207 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;114;108;112;114;114;102;114;114;108 13:00:09 INFO - 2015-12-16 13:00:09,207 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;132;152;167;135;149;161;131;176;130 13:00:09 INFO - 2015-12-16 13:00:09,207 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;164;161;163;163;161;162;162;161;164 13:00:09 INFO - 2015-12-16 13:00:09,207 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;78;93;73;72;72;112;90;72 13:00:09 INFO - 2015-12-16 13:00:09,207 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;143;94;95;95;136;95;96;140 13:00:09 INFO - 2015-12-16 13:00:09,207 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;110;110;110;109;110;110 13:00:09 INFO - 2015-12-16 13:00:09,208 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;148;148;147;147;147;147;147;148 13:00:09 INFO - 2015-12-16 13:00:09,208 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;96;95;95;95;95;96;95 13:00:09 INFO - 2015-12-16 13:00:09,208 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;73;71;72;74;72;72;81;71;71 13:00:09 INFO - 2015-12-16 13:00:09,208 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;69;69;70;70;69;70;70;69 13:00:09 INFO - 2015-12-16 13:00:09,208 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;84;84;84;85;84;84;85;85;84 13:00:09 INFO - 2015-12-16 13:00:09,208 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;126;122;120;128;120;128;138;123;128 13:00:09 INFO - 2015-12-16 13:00:09,208 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;146;145;147;148;137;149;148;148;135 13:00:09 INFO - 2015-12-16 13:00:09,209 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;71;72;69;70;72;68;73;69;68 13:00:09 INFO - 2015-12-16 13:00:09,209 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:00:09 INFO - 2015-12-16 13:00:09,209 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:00:09 INFO - 2015-12-16 13:00:09,209 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,981 13:00:09 INFO - 2015-12-16 13:00:09,209 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:00:09 INFO - 2015-12-16 13:00:09,209 DEBUG : BROWSER_OUTPUT: __startTimestamp1450299609205__endTimestamp 13:00:09 INFO - 2015-12-16 13:00:09,209 DEBUG : BROWSER_OUTPUT: 13:00:09 INFO - 2015-12-16 13:00:09,213 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:00:09 INFO - 2015-12-16 13:00:09,213 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:00:09 INFO - 2015-12-16 13:00:09,213 DEBUG : BROWSER_OUTPUT: 13:00:09 INFO - 2015-12-16 13:00:09,213 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.20 Median:114.00 stddev:4.02 (3.5%) stddev-sans-first:4.26 13:00:09 INFO - 2015-12-16 13:00:09,213 DEBUG : BROWSER_OUTPUT: Values: 112.0 114.0 108.0 112.0 114.0 114.0 102.0 114.0 114.0 108.0 13:00:09 INFO - 2015-12-16 13:00:09,213 DEBUG : BROWSER_OUTPUT: 13:00:09 INFO - 2015-12-16 13:00:09,213 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.90 Median:154.00 stddev:16.41 (10.7%) stddev-sans-first:17.21 13:00:09 INFO - 2015-12-16 13:00:09,213 DEBUG : BROWSER_OUTPUT: Values: 156.0 132.0 152.0 167.0 135.0 149.0 161.0 131.0 176.0 130.0 13:00:09 INFO - 2015-12-16 13:00:09,213 DEBUG : BROWSER_OUTPUT: 13:00:09 INFO - 2015-12-16 13:00:09,213 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.16 (0.7%) stddev-sans-first:1.22 13:00:09 INFO - 2015-12-16 13:00:09,213 DEBUG : BROWSER_OUTPUT: Values: 162.0 164.0 161.0 163.0 163.0 161.0 162.0 162.0 161.0 164.0 13:00:09 INFO - 2015-12-16 13:00:09,213 DEBUG : BROWSER_OUTPUT: 13:00:09 INFO - 2015-12-16 13:00:09,213 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:72.50 stddev:13.59 (18.7%) stddev-sans-first:14.05 13:00:09 INFO - 2015-12-16 13:00:09,213 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 78.0 93.0 73.0 72.0 72.0 112.0 90.0 72.0 13:00:09 INFO - 2015-12-16 13:00:09,213 DEBUG : BROWSER_OUTPUT: 13:00:09 INFO - 2015-12-16 13:00:09,214 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.30 Median:95.00 stddev:21.72 (22.9%) stddev-sans-first:22.41 13:00:09 INFO - 2015-12-16 13:00:09,214 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 143.0 94.0 95.0 95.0 136.0 95.0 96.0 140.0 13:00:09 INFO - 2015-12-16 13:00:09,214 DEBUG : BROWSER_OUTPUT: 13:00:09 INFO - 2015-12-16 13:00:09,214 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:00:09 INFO - 2015-12-16 13:00:09,214 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 13:00:09 INFO - 2015-12-16 13:00:09,214 DEBUG : BROWSER_OUTPUT: 13:00:09 INFO - 2015-12-16 13:00:09,214 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 13:00:09 INFO - 2015-12-16 13:00:09,214 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 148.0 148.0 147.0 147.0 147.0 147.0 147.0 148.0 13:00:09 INFO - 2015-12-16 13:00:09,214 DEBUG : BROWSER_OUTPUT: 13:00:09 INFO - 2015-12-16 13:00:09,214 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:00:09 INFO - 2015-12-16 13:00:09,214 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 13:00:09 INFO - 2015-12-16 13:00:09,214 DEBUG : BROWSER_OUTPUT: 13:00:09 INFO - 2015-12-16 13:00:09,214 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.00 Median:72.50 stddev:2.98 (4.1%) stddev-sans-first:3.16 13:00:09 INFO - 2015-12-16 13:00:09,214 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 71.0 72.0 74.0 72.0 72.0 81.0 71.0 71.0 13:00:09 INFO - 2015-12-16 13:00:09,214 DEBUG : BROWSER_OUTPUT: 13:00:09 INFO - 2015-12-16 13:00:09,214 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:70.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 13:00:09 INFO - 2015-12-16 13:00:09,215 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 69.0 70.0 70.0 69.0 70.0 70.0 69.0 13:00:09 INFO - 2015-12-16 13:00:09,215 DEBUG : BROWSER_OUTPUT: 13:00:09 INFO - 2015-12-16 13:00:09,215 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.50 stddev:2.16 (2.6%) stddev-sans-first:0.50 13:00:09 INFO - 2015-12-16 13:00:09,215 DEBUG : BROWSER_OUTPUT: Values: 91.0 84.0 84.0 84.0 85.0 84.0 84.0 85.0 85.0 84.0 13:00:09 INFO - 2015-12-16 13:00:09,215 DEBUG : BROWSER_OUTPUT: 13:00:09 INFO - 2015-12-16 13:00:09,215 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:127.00 stddev:5.86 (4.6%) stddev-sans-first:5.62 13:00:09 INFO - 2015-12-16 13:00:09,215 DEBUG : BROWSER_OUTPUT: Values: 118.0 126.0 122.0 120.0 128.0 120.0 128.0 138.0 123.0 128.0 13:00:09 INFO - 2015-12-16 13:00:09,215 DEBUG : BROWSER_OUTPUT: 13:00:09 INFO - 2015-12-16 13:00:09,215 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.50 Median:147.50 stddev:4.93 (3.3%) stddev-sans-first:5.14 13:00:09 INFO - 2015-12-16 13:00:09,215 DEBUG : BROWSER_OUTPUT: Values: 142.0 146.0 145.0 147.0 148.0 137.0 149.0 148.0 148.0 135.0 13:00:09 INFO - 2015-12-16 13:00:09,215 DEBUG : BROWSER_OUTPUT: 13:00:09 INFO - 2015-12-16 13:00:09,215 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:71.50 stddev:1.84 (2.6%) stddev-sans-first:1.86 13:00:09 INFO - 2015-12-16 13:00:09,216 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 72.0 69.0 70.0 72.0 68.0 73.0 69.0 68.0 13:00:09 INFO - 2015-12-16 13:00:09,216 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:00:09 INFO - 2015-12-16 13:00:09,216 DEBUG : BROWSER_OUTPUT: 13:00:10 INFO - 2015-12-16 13:00:10,034 INFO : Browser exited with error code: 0 13:00:10 INFO - 2015-12-16 13:00:10,088 INFO : Completed test kraken (00:01:01) 13:00:10 INFO - 2015-12-16 13:00:10,088 INFO : Starting test v8_7 13:00:10 INFO - 2015-12-16 13:00:10,088 DEBUG : operating with platform_type : linux_ 13:00:10 INFO - 2015-12-16 13:00:10,088 INFO : Initialising browser for v8_7 test... 13:00:10 INFO - 2015-12-16 13:00:10,094 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppTwayN/profile http://localhost:53860/getInfo.html 13:00:14 INFO - 2015-12-16 13:00:14,880 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:00:14 INFO - 2015-12-16 13:00:14,880 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:00:14 INFO - 2015-12-16 13:00:14,881 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:00:14 INFO - 2015-12-16 13:00:14,881 DEBUG : BROWSER_OUTPUT: __metrics 13:00:14 INFO - 2015-12-16 13:00:14,997 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] 13:00:15 INFO - 2015-12-16 13:00:15,074 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:00:15 INFO - 2015-12-16 13:00:15,965 INFO : Browser initialized. 13:00:15 INFO - 2015-12-16 13:00:15,966 INFO : Running cycle 1/1 for v8_7 test... 13:00:15 INFO - 2015-12-16 13:00:15,966 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppTwayN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:00:27 INFO - 2015-12-16 13:00:27,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 143167488 13:00:27 INFO - 2015-12-16 13:00:27,973 DEBUG : BROWSER_OUTPUT: 13:00:49 INFO - 2015-12-16 13:00:49,346 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53860/tests/v8_7/run.html (next: http://localhost:53860/tests/v8_7/run.html) 13:00:49 INFO - 2015-12-16 13:00:49,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 442195968 13:00:49 INFO - 2015-12-16 13:00:49,596 DEBUG : BROWSER_OUTPUT: 13:00:49 INFO - 2015-12-16 13:00:49,596 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:00:49 INFO - 2015-12-16 13:00:49,596 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:00:49 INFO - 2015-12-16 13:00:49,596 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:00:49 INFO - 2015-12-16 13:00:49,596 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:00:49 INFO - 2015-12-16 13:00:49,597 DEBUG : BROWSER_OUTPUT: |0;Richards;166.72224074691565 13:00:49 INFO - 2015-12-16 13:00:49,597 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.74136321195144 13:00:49 INFO - 2015-12-16 13:00:49,597 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.2516056967328 13:00:49 INFO - 2015-12-16 13:00:49,597 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 13:00:49 INFO - 2015-12-16 13:00:49,597 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2004.0080160320642 13:00:49 INFO - 2015-12-16 13:00:49,597 DEBUG : BROWSER_OUTPUT: |5;Earley;795.5449482895783 13:00:49 INFO - 2015-12-16 13:00:49,597 DEBUG : BROWSER_OUTPUT: |6;Boyer;12395.061728395061 13:00:49 INFO - 2015-12-16 13:00:49,597 DEBUG : BROWSER_OUTPUT: |7;RegExp;27378.37837837838 13:00:49 INFO - 2015-12-16 13:00:49,597 DEBUG : BROWSER_OUTPUT: |8;Splay;607.1645415907711 13:00:49 INFO - 2015-12-16 13:00:49,598 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4859.223300970873 13:00:49 INFO - 2015-12-16 13:00:49,598 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:00:49 INFO - 2015-12-16 13:00:49,598 DEBUG : BROWSER_OUTPUT: __startTimestamp1450299649594__endTimestamp 13:00:49 INFO - 2015-12-16 13:00:49,598 DEBUG : BROWSER_OUTPUT: 13:00:49 INFO - 2015-12-16 13:00:49,598 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:00:49 INFO - 2015-12-16 13:00:49,599 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:00:49 INFO - 2015-12-16 13:00:49,599 DEBUG : BROWSER_OUTPUT: 13:00:49 INFO - 2015-12-16 13:00:49,599 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.72 Median:166.72 stddev:0.00 (0.0%) 13:00:49 INFO - 2015-12-16 13:00:49,599 DEBUG : BROWSER_OUTPUT: Values: 166.7 13:00:49 INFO - 2015-12-16 13:00:49,599 DEBUG : BROWSER_OUTPUT: 13:00:49 INFO - 2015-12-16 13:00:49,600 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.74 Median:186.74 stddev:0.00 (0.0%) 13:00:49 INFO - 2015-12-16 13:00:49,600 DEBUG : BROWSER_OUTPUT: Values: 186.7 13:00:49 INFO - 2015-12-16 13:00:49,600 DEBUG : BROWSER_OUTPUT: 13:00:49 INFO - 2015-12-16 13:00:49,601 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 13:00:49 INFO - 2015-12-16 13:00:49,601 DEBUG : BROWSER_OUTPUT: Values: 279.3 13:00:49 INFO - 2015-12-16 13:00:49,601 DEBUG : BROWSER_OUTPUT: 13:00:49 INFO - 2015-12-16 13:00:49,601 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 13:00:49 INFO - 2015-12-16 13:00:49,601 DEBUG : BROWSER_OUTPUT: Values: 5133.3 13:00:49 INFO - 2015-12-16 13:00:49,602 DEBUG : BROWSER_OUTPUT: 13:00:49 INFO - 2015-12-16 13:00:49,602 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2004.01 Median:2004.01 stddev:0.00 (0.0%) 13:00:49 INFO - 2015-12-16 13:00:49,602 DEBUG : BROWSER_OUTPUT: Values: 2004.0 13:00:49 INFO - 2015-12-16 13:00:49,602 DEBUG : BROWSER_OUTPUT: 13:00:49 INFO - 2015-12-16 13:00:49,602 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:795.54 Median:795.54 stddev:0.00 (0.0%) 13:00:49 INFO - 2015-12-16 13:00:49,602 DEBUG : BROWSER_OUTPUT: Values: 795.5 13:00:49 INFO - 2015-12-16 13:00:49,602 DEBUG : BROWSER_OUTPUT: 13:00:49 INFO - 2015-12-16 13:00:49,602 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 13:00:49 INFO - 2015-12-16 13:00:49,602 DEBUG : BROWSER_OUTPUT: Values: 12395.1 13:00:49 INFO - 2015-12-16 13:00:49,602 DEBUG : BROWSER_OUTPUT: 13:00:49 INFO - 2015-12-16 13:00:49,602 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27378.38 Median:27378.38 stddev:0.00 (0.0%) 13:00:49 INFO - 2015-12-16 13:00:49,602 DEBUG : BROWSER_OUTPUT: Values: 27378.4 13:00:49 INFO - 2015-12-16 13:00:49,602 DEBUG : BROWSER_OUTPUT: 13:00:49 INFO - 2015-12-16 13:00:49,602 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:607.16 Median:607.16 stddev:0.00 (0.0%) 13:00:49 INFO - 2015-12-16 13:00:49,602 DEBUG : BROWSER_OUTPUT: Values: 607.2 13:00:49 INFO - 2015-12-16 13:00:49,602 DEBUG : BROWSER_OUTPUT: 13:00:49 INFO - 2015-12-16 13:00:49,603 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 13:00:49 INFO - 2015-12-16 13:00:49,603 DEBUG : BROWSER_OUTPUT: Values: 4859.2 13:00:49 INFO - 2015-12-16 13:00:49,603 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:00:49 INFO - 2015-12-16 13:00:49,603 DEBUG : BROWSER_OUTPUT: 13:00:50 INFO - 2015-12-16 13:00:50,538 INFO : Browser exited with error code: 0 13:00:50 INFO - 2015-12-16 13:00:50,552 INFO : Completed test v8_7 (00:00:40) 13:00:50 INFO - 2015-12-16 13:00:50,641 INFO : Completed test suite (00:20:19) 13:00:50 INFO - 2015-12-16 13:00:50,641 DEBUG : Working with test: dromaeo_css 13:00:50 INFO - 2015-12-16 13:00:50,642 DEBUG : Generating results file: dromaeo_css 13:00:50 INFO - 2015-12-16 13:00:50,643 DEBUG : Working with test: kraken 13:00:50 INFO - 2015-12-16 13:00:50,643 DEBUG : Generating results file: kraken 13:00:50 INFO - 2015-12-16 13:00:50,643 INFO : javascript benchmark 13:00:50 INFO - 2015-12-16 13:00:50,643 DEBUG : Working with test: v8_7 13:00:50 INFO - 2015-12-16 13:00:50,643 DEBUG : Generating results file: v8_7 13:00:50 INFO - 2015-12-16 13:00:50,644 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:00:50 INFO - 2015-12-16 13:00:50,712 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 13:00:50 INFO - 2015-12-16 13:00:50,712 DEBUG : process_Request line: dromaeo_css 6286.30 graph.html#tests=[[72,132,35]] 13:00:50 INFO - 2015-12-16 13:00:50,712 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:00:50 INFO - 2015-12-16 13:00:50,827 DEBUG : process_Request line: kraken 1531.10 graph.html#tests=[[232,132,35]] 13:00:50 INFO - 2015-12-16 13:00:50,827 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:00:51 INFO - 2015-12-16 13:00:51,011 DEBUG : process_Request line: v8_7 19687.02 graph.html#tests=[[230,132,35]] 13:00:51 INFO - 2015-12-16 13:00:51,013 INFO : javascript benchmark 13:00:51 INFO - 2015-12-16 13:00:51,016 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2610.843349399036, 2709.309126172827, 2717.904873329434, 2720.687120981088, 2725.7955653326, 4522.14079324928, 4704.106219818232, 4754.548317909793, 4776.092542416943, 4776.4507081685615, 4708.929366059512, 4712.1518126737255, 4771.665983381165, 4783.928241076378, 4785.234362502, 4302.935455968147, 4377.584129507692, 4400.933985990213, 4409.074094440171, 4428.047969686517, 4241.766702831343, 4327.545607711177, 4355.237833379162, 4419.801108950105, 4449.7330160190495, 4313.374560688714, 4338.501072376685, 4398.296272596369, 4402.053558484941, 4429.42417485728, 4344.9128188329105, 4359.237133501656, 4374.103308821684, 4385.166818304512, 4432.445944256968, 4197.727147735387, 4281.743095414286, 4336.111097225062, 4341.674374421931, 4389.692721509496, 4555.0, 4570.611498022672, 4657.0, 4676.649251306131, 4706.129366067288, 5088.465711100318, 5092.869982025158, 5093.414257360377, 5095.898082038376, 5145.125328694131, 4865.489123642002, 4981.302617633534, 5128.076946149691, 5129.666571672867, 5139.7687104080405, 4634.443866736014, 4669.929951050737, 4708.4349878014855, 4719.504452032487, 4756.6908150970075, 5166.9224961625605, 5169.948300517022, 5186.6369354144845, 5195.896082078338, 5235.73821308933, 4788.832390866303, 4902.950970490249, 4976.328195693607, 4984.177610694195, 4987.451380348159, 4991.575716064102, 5038.874028149326, 5077.1876499759865, 5082.059818933509, 5088.389393272757, 5014.0974624567925, 5045.84862454127, 5052.242163675478, 5064.46823083571, 5081.441041485434, 4804.495527969582, 4917.532834380728, 5003.24951257307, 5015.749212539358, 5018.42288136869, 4139.110091330318, 4150.5641907599875, 4215.873523794291, 4227.6406505447385, 4237.0, 3693.2798104369926, 3703.7407381483035, 3705.7961812100593, 3741.2704522618374, 3744.363458212056, 4352.564743525622, 4389.385486031958, 4392.3850660906855, 4397.824087036547, 4434.445694288214, 4843.685160464559, 4930.0, 4952.083864485082, 4956.677815941952, 5019.899602007939, 4380.123975204971, 4382.8904277392685, 4383.3863259143745, 4387.890302742393, 4418.138462999748, 4493.438320209973, 4496.482904465963, 4498.482674492409, 4498.572635599613, 4536.931946020813, 4637.42032245976, 4739.146953548395, 4753.904921901473, 4764.237721964469, 4848.272759086165, 5060.2156665716875, 5075.2387141929, 5080.669756465818, 5084.211947148198, 5100.030994111107, 4833.419989601271, 4838.685485443435, 4839.467658557626, 4840.540148685869, 4870.756462176806, 4804.42346918372, 4905.043516514245, 4914.0908931847725, 4916.729579872998, 5054.039732450822, 5085.338905942203, 5093.108705976365, 5117.795288188431, 5118.820841270538, 5122.026814905156, 4937.876553086202, 4938.555530002317, 4942.456329803646, 4946.060248552763, 4978.054169707744, 4717.457492388419, 4829.179039563212, 4831.444383895757, 4932.30947667334, 4993.201087825931, 4752.691075080109, 4788.712677239377, 4817.759112044454, 4824.541668541483, 4861.076395484846, 4879.536444037811, 4918.2376731606655, 4922.0, 4948.66703493032, 4963.255511673278, 4655.650826187982, 4757.26262429324, 4769.236922092448, 4830.975665679804, 4865.951340486691], "unit": "score", "name": "dojo.html", "value": 4630.445727460897}, {"lowerIsBetter": false, "replicates": [562.4347530731617, 563.4281204577353, 570.9000924838152, 571.9456651618096, 573.6386076771633, 26057.088001919936, 34627.826860865694, 35066.29867402657, 35257.47113793295, 35352.82323588385, 39137.804310978405, 39462.40806387906, 39473.80263098681, 39597.60402395975, 39698.60301396985, 6995.265497122779, 7109.644517774116, 7823.374130069595, 7984.041914970212, 7987.440879138463, 10119.241056920724, 10375.42935138567, 10382.377057376543, 10387.0, 10393.428361440117, 10019.248556358265, 10142.188624910026, 10149.644762433316, 10149.847752283722, 10152.54313555888, 6962.512624116314, 7106.147262328502, 10016.098551130397, 10194.898051019543, 10443.164546836235, 9819.165370943478, 9874.111329980264, 9933.10602045812, 9952.601895924154, 9954.651587194414, 37060.44409333862, 37601.62398376009, 37632.43551346732, 37643.24713505742, 37647.0, 2896.1456370370793, 2902.34697193132, 3446.603640581315, 3643.908902277438, 3685.281370132825, 27482.45035099287, 27648.170554883385, 27813.582796258073, 28389.85805070982, 28765.424691506054, 2425.527022230666, 3111.673274306188, 3254.7721659483846, 3318.286568387784, 3341.916452088693, 150244.0, 150807.24596376947, 166877.0, 167023.16488417602, 167259.0, 49026.0, 49384.75307623439, 49411.0, 49446.50553494491, 49526.75236623866, 51852.0, 52108.47891521112, 52144.73927630338, 52180.0, 52246.47753522416, 14142.50501232452, 14662.340194691264, 14667.046641968238, 14668.55994320172, 14686.339114739649, 11117.94379533943, 11184.832227516594, 11203.94398028021, 11211.60759373418, 11222.831657525143, 17643.55891102707, 17703.911480442774, 17768.644627107384, 17794.288228470716, 17837.821621783874, 7023.5379665508635, 7188.640567971581, 7250.3112204340505, 7327.230640782747, 7327.377172940253, 798.7244400681756, 803.4215364937236, 810.5177419435427, 818.1532114261711, 835.6657337065222, 27091.864540677172, 27609.137307368237, 27629.723702763116, 27743.30641733973, 27786.16641500758, 709.1596458197052, 841.7643059943226, 864.2783275964514, 887.7114937645161, 901.6799036342135, 13041.543545975845, 14081.08472949255, 14187.219702916438, 14205.502807401692, 14239.715205696035, 295675.0, 300245.0, 300798.0, 301005.0, 301016.0, 43909.341359879625, 44421.0, 45005.77497112559, 45344.54655453469, 46671.533284666715, 1230.926144431337, 1259.1311994723612, 1259.1500737002486, 1270.764908491932, 1271.6058022013206, 27065.72934270632, 27405.314867127683, 28166.85916570404, 28232.29419264535, 28470.85764571164, 35381.64618353886, 35835.0, 39542.40686389764, 40198.0, 40203.39694904637, 165346.0, 166158.0, 166502.0, 166740.0, 166756.16621916814, 28555.857220713762, 28678.71321286844, 28704.856475717486, 28909.0, 28959.0, 36964.0, 37914.24171516609, 38535.6146438532, 38595.421068684554, 38729.80635096919, 32144.83927580347, 32494.35011299808, 32716.182095447803, 32901.50647740334, 33310.66689333076, 32465.51301730523, 32572.913082718274, 32596.674033259365, 32749.181270468427, 32826.17934551655, 32046.83976580102, 32500.18749531186, 32598.837005814818, 32724.509132362557, 32757.67242327546, 28921.132366029055, 29397.706022940354, 29933.700662993964, 34197.487037694955, 35534.46698299476, 23619.937102830758, 23706.88146559256, 23735.643965340187, 23847.284581462583, 24126.396840078436], "unit": "score", "name": "ext.html", "value": 16730.087787361637}, {"lowerIsBetter": false, "replicates": [339.4263694356537, 340.0682130961167, 341.88546836809667, 342.98113603751784, 347.3417873130418, 12466.812997805018, 12885.613431597067, 14760.557183284505, 14835.703285934274, 15561.688766224683, 12772.744545109115, 14873.851261487382, 15818.683626327494, 16170.595735106599, 16193.352265909349, 4853.077915196111, 4859.173940430118, 5018.172001619747, 5019.071471777733, 5033.773480193382, 3720.869769558066, 3849.056981039635, 4990.426100998396, 5014.997000599877, 5546.0, 5668.829935101933, 5695.202671625976, 5715.171300161474, 5721.0, 5721.713914304289, 5282.683039017671, 5285.86785330366, 5288.762005709752, 5430.15832545956, 5684.147377893308, 4944.777485013183, 5067.442581316089, 5078.695278283315, 5079.847604571869, 5085.0338435697095, 18985.0, 19295.614087718306, 19492.902535487232, 19707.0, 19722.309719159904, 1858.5725283184809, 1882.7081802320663, 1882.7834798998153, 1979.4556496963307, 2035.328341647253, 8040.758777236692, 8125.959370203112, 8233.17668233178, 8323.750287491384, 8356.874646880302, 1744.7034004219313, 1747.790265168188, 1780.5726625609761, 1826.9086545672662, 1836.164545131975, 51796.741016295055, 54060.45939540594, 54237.45762542403, 54329.456705432836, 54958.72520637371, 9817.656382026595, 9834.262430317754, 9873.555689993967, 9881.209503239723, 9943.850842237372, 12566.623001309976, 12576.11967162308, 12580.308083055337, 12583.559575414816, 12586.0, 7210.423166146696, 7283.781486555412, 7284.963575182091, 7341.082364704412, 7352.889706654404, 7018.297740513868, 7036.401905838061, 7083.574985500886, 7096.361327480448, 7109.253528379446, 4150.896227594274, 4171.353440216772, 4194.475690538683, 4195.391668208093, 4229.154169166179, 1607.1401800036924, 1640.6554623528955, 1691.6109294862251, 1709.2821015173656, 1713.4859542137308, 838.3795990966763, 849.8470275350372, 858.9484630922165, 876.7895705030875, 1004.57305645102, 15316.387344506094, 15395.677745048388, 15644.608884777972, 15844.207789610473, 16263.268152933146, 725.7278520554792, 799.9880001799978, 881.0308660473428, 895.136193573205, 948.3361646847235, 8541.27399171065, 8628.96452425713, 8704.564771761387, 8914.28685705142, 9257.49083800384, 496293.2335696309, 504739.66822322085, 506487.0, 516701.0, 519455.0, 68431.65784171048, 70452.64773676201, 72080.27919720841, 72636.0, 72984.0, 1047.4239168457318, 1102.6691992402248, 1106.7952428800697, 1114.3926560024806, 1115.3865374044244, 14356.0, 14428.711425771216, 14472.710545788814, 14560.126392416489, 14637.487687930872, 33248.335033299685, 33366.83316583402, 33827.58758598711, 33896.49155262722, 33959.75503062117, 42339.0, 42917.57082429136, 44446.333304999804, 45034.87412814706, 45298.508582028306, 8087.676492940216, 8304.169583041648, 8328.292095171979, 8329.0, 8750.956245218733, 10212.387256764618, 10221.131203847459, 10229.488525573543, 10317.793644126925, 10786.514606842868, 13299.534516291884, 13317.134386264861, 13483.056186067273, 13526.93236533811, 13667.658308542366, 12962.0, 13153.736925261632, 13193.274369909746, 13502.797458037941, 13606.52377166834, 14325.355359009078, 14552.708945821236, 14603.415863365772, 14623.0, 14856.851431485979, 9209.125133112344, 9236.584353703965, 9264.861027084735, 9269.582868771056, 9317.39436936597, 12967.0, 13466.596002119952, 13512.189268643913, 13727.588172354845, 13923.4430622778], "unit": "score", "name": "jquery.html", "value": 8224.136129119772}, {"lowerIsBetter": false, "replicates": [1263.5261776833688, 1419.3967563785388, 1422.3954819201836, 1650.331615695643, 1710.3842616658005, 6015.578909476333, 7066.2580429054915, 7270.054892863934, 7271.963640181805, 7292.890606640898, 7126.643667816615, 7251.238619944909, 7267.30960558746, 7269.418446524279, 7286.744963926264, 1746.4673274651227, 1767.9558011049699, 2069.844761642883, 2079.4593405714472, 2112.915483380663, 2106.947326316839, 2109.820665243456, 2119.7138386317806, 2121.9257325993594, 2126.797954194349, 2026.7466566679166, 2046.4679183412345, 2068.9275875344365, 2069.4515953272394, 2070.3581889614193, 2050.1389416445127, 2059.166037754704, 2074.284371891695, 2119.247667078188, 2119.4171602809274, 2112.112912576706, 2125.7130287411155, 2134.6691262854283, 2135.4234356723755, 2136.7115439415634, 7183.92816071843, 7262.237465066198, 7265.019222404961, 7267.745628903016, 7277.053982982231, 4165.97917010416, 4184.958150418487, 4206.642435392995, 4206.663466922639, 4215.114825886537, 2654.9336266593295, 2673.42521357909, 2705.7700095491905, 2711.2544050386105, 2715.701272859984, 820.5897051474263, 827.1686954610578, 833.9624716887755, 853.1809462915609, 854.3165467625937, 9857.309988300893, 9919.553620087114, 9920.603175872957, 9935.950320248352, 9953.452560109192, 3987.6809855211513, 4007.6192761687594, 4050.7569545827346, 4051.513818341818, 4054.9189016220103, 8455.957720211483, 8481.787955301166, 8503.319734421231, 8519.914800851911, 8527.317814574819, 4322.7190232634775, 4339.956600433955, 4345.630621397154, 4347.934780978288, 4348.28253338202, 3937.940930886039, 3942.3495123304906, 3945.072907866649, 3945.8027098644952, 3947.5657677655436, 3051.4354844353866, 3086.058752080637, 3115.9221019474694, 3142.3244002539564, 3511.1924257420424, 1116.3580940958982, 1121.6803211084803, 1123.3260043973714, 1123.5056575106926, 1127.3968426891574, 912.9954350228339, 917.9265658747285, 935.5976929920199, 987.2940847294219, 1138.7779383020231, 6843.726250949906, 6897.586144831226, 6920.9653951729915, 6921.446284297244, 6923.5460553283365, 1050.5115121468555, 1124.3029321820525, 1135.7047167736448, 1150.730788773659, 1161.6108603617713, 5052.368453943257, 5074.797008119708, 5091.770870310771, 5099.490050994871, 5102.617303702163, 8648.740537783877, 8677.0, 8683.435576687496, 8809.955950220208, 8901.465912045298, 8645.481271123752, 8706.564671766386, 8706.825863482694, 8714.041455439896, 8714.694985675598, 6744.595324280559, 6814.284500127515, 6853.383195512328, 6887.070245516791, 6899.793006209822, 6591.307912669293, 6599.505037122139, 6629.7679581214425, 6630.0, 6636.502262330441, 7460.7015719372785, 7706.152323244551, 7752.961235193788, 7792.493487923267, 7794.922050779646, 7886.093099293655, 7894.644740986554, 7977.680892764457, 8111.594420279081, 8120.878186827321, 6495.577787443801, 6562.901556476561, 6565.244996825426, 6580.374864387875, 6581.210254769267, 6291.087792270004, 6300.243970723543, 6345.873082538231, 6372.107904893226, 6984.511084224258, 6283.528735344776, 6387.616742995435, 6399.712012959521, 6509.902351464637, 6588.769393071219, 6185.969070154621, 6202.596831205957, 6241.282252541016, 6278.46633036197, 6283.528735344776, 6430.3891130342545, 6589.4069533742195, 6592.43964263043, 6597.60414375139, 6609.339066093352, 6003.0695242237525, 6030.095485677008, 6031.24609423822, 6034.969825150846, 6035.064564992434, 5945.970270148795, 6009.489193418608, 6011.128386384037, 6065.423784740443, 6100.603460775035], "unit": "score", "name": "mootools.html", "value": 4118.623330282743}, {"lowerIsBetter": false, "replicates": [299.9475091858925, 303.57044781633994, 303.64018637914074, 310.6117353308366, 311.1350445760783, 5339.145736682131, 5339.919901201481, 5357.571394288462, 5375.516203541681, 5396.541293990015, 5092.79628814847, 5169.3279873616375, 5228.816991405301, 5299.894002119955, 5346.91979620305, 4129.690273229505, 4154.85458008969, 4164.791760411982, 4172.395002724603, 4174.039970806716, 3949.486566746333, 4148.253314403406, 4159.334506478964, 4164.916701665965, 4172.18642364739, 4020.517537895457, 4028.7179897407195, 4127.8968025799295, 4143.803783994488, 4148.0, 4124.278251306009, 4126.504819421673, 4135.35901935199, 4135.627793498599, 4137.606927341898, 3655.8354874030733, 3660.2313514162056, 3661.1030297577, 3665.981670091659, 3667.2848794485085, 5123.1546794778815, 5133.204353325241, 5136.8202112925865, 5146.073706732786, 5149.201873709581, 4526.93209601853, 4678.578927896471, 4695.201815691306, 4697.530246975275, 4761.571458568711, 5547.417521160261, 5554.472325129106, 5566.916496252559, 5567.693776842272, 5573.247611572427, 3852.171783066626, 3855.8264878080554, 3857.9807100964595, 3861.826217820205, 3865.632764887331, 5791.3629500755305, 5866.354700982888, 5870.706464676749, 5874.030784920483, 5874.676892770896, 3899.122697393064, 4010.979945100256, 4012.6990475713856, 4023.295923213426, 4033.253848038122, 4076.1236334188293, 4079.0618157823274, 4082.3672330788777, 4084.0606660467665, 4085.4688890444054, 4660.930086048712, 4670.859874203779, 4673.130747700879, 4680.040591678698, 4680.063987202505, 5571.526420254324, 5578.832635020955, 5585.5531557476115, 5586.469285417878, 5589.217509548666, 1400.4328247059957, 1415.7451658701327, 1415.9882950204803, 1428.435767871685, 1445.197915157077, 947.8767760191131, 948.4783369146942, 952.8046750416148, 955.0783493928393, 956.0582825916466, 4921.680090794087, 4932.827351042696, 4934.6545741798445, 4936.062148191832, 4939.135651261015, 5803.448672376202, 5808.273965754281, 5810.622309549865, 5812.651240925558, 5815.88368232633, 4767.809287628456, 4853.0, 4853.830115945925, 4923.48303428142, 4991.425986011655, 3119.6256449225784, 3122.953155702666, 3142.214446388403, 3146.0719087869134, 3159.77881548294, 5492.917606235909, 5546.86132846674, 5554.527865131509, 5557.888842223133, 5561.972190139104, 5851.531877449794, 6000.369961154103, 6004.669743164168, 6006.579539432285, 6006.879862402815, 5558.055130627803, 5559.416261292506, 5560.082586373203, 5560.360558535739, 5561.610687251934, 5842.065269556851, 5850.12248162779, 5855.502282305882, 5857.384974577608, 5863.413658634103, 5700.942990570041, 5713.428657134254, 5715.199872017838, 5715.457031581993, 5724.8282551523525, 5362.65142765719, 5543.279373681396, 5548.916766248429, 5562.610617256753, 5571.777128914798, 3953.288408086572, 3987.5613682494322, 3989.082511022423, 3994.0813612869783, 3995.220931918248, 5817.5345972321265, 5841.386654401226, 5843.912341314799, 5848.327442344185, 5852.853678658068, 5424.728763561727, 5575.665460072409, 5583.916241256466, 5589.469000444951, 5596.440355964533, 5618.831435056954, 5620.9156862647915, 5621.550275977994, 5623.3533143689, 5634.605577609528, 5492.176173573996, 5498.285222920995, 5499.835004949858, 5502.724863756876, 5514.834554963358, 5641.661500309994, 5659.094544872801, 5660.320761508646, 5664.603477756517, 5665.206871037975, 5388.946110538845, 5510.063289240758, 5510.8071217507195, 5517.889642207214, 5520.834374968757], "unit": "score", "name": "prototype.html", "value": 4208.174105602781}, {"lowerIsBetter": false, "replicates": [643.7682434323644, 689.3416786968446, 727.5198369076411, 758.4614923404382, 776.0028363552835, 11716.238444501101, 11847.585334513295, 11924.940375298122, 11927.403629818518, 11944.22362546435, 11432.37121958292, 11481.425928703553, 11522.884771152287, 11529.884701152985, 11544.307341559512, 628.7233617208436, 630.8139098965817, 638.4317957018258, 639.6961443314411, 802.6588699802561, 793.769806756043, 803.5660743198665, 809.7854068671807, 811.1928631012122, 811.4765975945512, 852.1606217875387, 861.8190180062163, 862.0388267082221, 862.3187681731456, 862.7498025572577, 661.3849120318126, 670.2359310386188, 833.6498670558381, 853.3940901959554, 857.8455877941968, 631.09753053134, 631.255118959632, 632.8512799492115, 633.4615576759763, 633.6039975015615, 11260.155488338325, 11299.378534180616, 11317.886821131766, 11328.26366286197, 11344.943275283653, 10718.624848130356, 10884.891151088466, 11066.170037247159, 11104.61133860319, 11304.660860174208, 9542.713718588384, 9558.95220523893, 9627.374220675703, 9671.613135474572, 9704.854427183598, 3212.16483714236, 3232.4343239933155, 3250.902472925816, 3257.5113732940013, 3278.606567211926, 37842.81078594617, 38339.0, 38345.61654383476, 38520.614793851986, 38552.22895542073, 9028.09719028092, 9133.81732365349, 9245.537723113817, 9287.349885508085, 9324.0, 16038.679226415406, 16082.0, 16095.356185752438, 16108.516744497683, 16166.919165404097, 6096.29892562361, 6269.7492100316385, 6276.686165691697, 6309.526785491106, 6317.684115794192, 3502.2120022994623, 3518.5601799775027, 3530.435130379127, 3547.1486843157973, 3581.71346292296, 2465.7287698353166, 2535.404180017731, 2536.720960694322, 2539.7206307306183, 2540.7078186008844, 452.6763364194551, 455.4762023672803, 461.2757969987088, 467.68197625614226, 470.1419908666697, 473.673165515793, 592.4904582059426, 605.4581149870929, 612.9570930034944, 616.8642898562309, 7861.764147075597, 8836.293096552261, 8939.776505587282, 9006.954965225132, 9054.366194366463, 450.6957803482636, 453.3222831866315, 579.458206576852, 634.6636282770139, 656.2158220926043, 3847.826847791856, 3875.9806200968815, 3889.805509724559, 3901.395283731026, 3974.002409387716, 48073.519264807604, 49027.75486122618, 49146.508534914195, 49151.0, 49449.75275123673, 42996.57003429988, 43813.34279985803, 43908.341374879405, 44041.339379909325, 44300.556994430284, 40727.18545629071, 41192.79403603023, 41280.0, 41652.37521437181, 41842.58157418448, 7547.0, 7623.123340815877, 7663.27198916102, 7686.884696729442, 7797.883031754414, 30111.397772044875, 30421.39157216799, 30548.236294092825, 30861.0, 30883.69116308898, 35526.822365888, 38833.0, 39316.213675725754, 39498.48275034587, 39541.2091758169, 9335.0, 9803.313768036169, 9811.558479868565, 9839.508024598885, 9914.752131196778, 10227.335223210468, 10313.9484302581, 10382.42896640692, 10398.168146548409, 10424.113950314308, 9493.952530237304, 9515.143637072697, 9538.856917146388, 9556.61773529051, 9611.327207095715, 9670.129688328085, 9676.0, 9703.66037188695, 9748.415095094317, 9754.658586949423, 9832.213422926006, 9943.751406214613, 9970.202383809423, 9999.20006399501, 10025.849612255675, 8679.739607811776, 8752.34357423183, 8786.780330491789, 8835.116488351114, 8968.910310896808, 8354.832903342021, 8588.098249683693, 8626.482411055105, 8739.912600874164, 8926.375153739436], "unit": "score", "name": "yui.html", "value": 5588.14973010146}], "name": "dromaeo_css", "value": 6286.29733381816}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 108.0, 112.0, 114.0, 114.0, 102.0, 114.0, 114.0, 108.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [156.0, 132.0, 152.0, 167.0, 135.0, 149.0, 161.0, 131.0, 176.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 161.0, 163.0, 163.0, 161.0, 162.0, 162.0, 161.0, 164.0], "unit": "score", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 78.0, 93.0, 73.0, 72.0, 72.0, 112.0, 90.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 143.0, 94.0, 95.0, 95.0, 136.0, 95.0, 96.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 71.0, 72.0, 74.0, 72.0, 72.0, 81.0, 71.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 73.0}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 69.0, 70.0, 70.0, 69.0, 70.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [91.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [118.0, 126.0, 122.0, 120.0, 128.0, 120.0, 128.0, 138.0, 123.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.1}, {"lowerIsBetter": true, "replicates": [142.0, 146.0, 145.0, 147.0, 148.0, 137.0, 149.0, 148.0, 148.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.5}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 69.0, 70.0, 72.0, 68.0, 73.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1531.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.72224074691565], "unit": "score", "name": "Richards", "value": 211.74139599999998}, {"lowerIsBetter": false, "replicates": [186.74136321195144], "unit": "score", "name": "DeltaBlue", "value": 354.06189}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [2004.0080160320642], "unit": "score", "name": "RayTrace", "value": 369.254511}, {"lowerIsBetter": false, "replicates": [795.5449482895783], "unit": "score", "name": "Earley", "value": 837.743991}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [27378.37837837838], "unit": "score", "name": "RegExp", "value": 33.27388450148074}, {"lowerIsBetter": false, "replicates": [607.1645415907711], "unit": "score", "name": "Splay", "value": 134.21567700000003}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7", "value": 19687.017196468794}]} 13:00:51 INFO - RETURN: dromaeo_css: 6286.30 13:00:51 INFO - RETURN: kraken: 1531.10 13:00:51 INFO - RETURN: v8_7: 19687.02 13:00:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19687.02"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1531.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6286.30"}}} 13:00:51 INFO - Return code: 0 13:00:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:00:51 ERROR - # TBPL SUCCESS # 13:00:51 INFO - Running post-action listener: _resource_record_post_action 13:00:51 INFO - Running post-run listener: _resource_record_post_run 13:00:52 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 506081280; Read time: 8; Write time: 404104 13:00:52 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 231632896; Read time: 0; Write time: 259420 13:00:52 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273584128; Read time: 8; Write time: 144636 13:00:52 INFO - Running post-run listener: _upload_blobber_files 13:00:52 INFO - Blob upload gear active. 13:00:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:00:52 INFO - Copying logs to upload dir... 13:00:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.143399 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-16 13:00:51.878153) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 13:00:51.881851) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010001 build_url: 'https://queue.taskcluster.net/v1/task/4-p-qWeRTKW4vLZSumhtXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 13:00:51.932127) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:00:51.932501) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450294400.954434-1724481929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:00:51.982175) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 13:00:51.982539) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 13:00:51.982827) ========= ========= Total master_lag: 0.26 =========