builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1450381833.23 results: success (0) buildid: 20151217111251 builduid: 8db484571edd4e8bafa68a6de5cde574 revision: 6a2ad662612370d248530465d690785c20abcf0b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 11:50:33.228215) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 11:50:33.228787) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 11:50:33.229216) ========= 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=6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006487 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 11:50:33.261115) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 11:50:33.261432) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 11:50:33.302838) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:50:33.303144) ========= 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=6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004612 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:50:33.356135) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 11:50:33.356773) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 11:50:33.357300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:50:33.357651) ========= 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=6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 11:50:33-- 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% 223M=0s 2015-12-17 11:50:34 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.191314 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:50:33.564724) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:50:33.565047) ========= 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=6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019255 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:50:33.615683) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 11:50:33.616021) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6a2ad662612370d248530465d690785c20abcf0b --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 6a2ad662612370d248530465d690785c20abcf0b --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=6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 11:50:34,224 truncating revision to first 12 chars 2015-12-17 11:50:34,224 Setting DEBUG logging. 2015-12-17 11:50:34,224 attempt 1/10 2015-12-17 11:50:34,224 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6a2ad6626123?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 11:50:35,660 unpacking tar archive at: fx-team-6a2ad6626123/testing/mozharness/ program finished with exit code 0 elapsedTime=1.948900 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 11:50:35.578379) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 11:50:35.578747) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 11:50:35.586778) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 11:50:35.587071) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 11:50:35.587519) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-17 11:50:35.587861) ========= /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=6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:50:36 INFO - MultiFileLogger online at 20151217 11:50:36 in /builds/slave/test 11:50:36 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 11:50:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:50:36 INFO - {'append_to_log': False, 11:50:36 INFO - 'base_work_dir': '/builds/slave/test', 11:50:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:50:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:50:36 INFO - 'branch': 'Fx-Team-Non-PGO', 11:50:36 INFO - 'buildbot_json_path': 'buildprops.json', 11:50:36 INFO - 'config_files': ('talos/linux_config.py',), 11:50:36 INFO - 'default_actions': ('clobber', 11:50:36 INFO - 'read-buildbot-config', 11:50:36 INFO - 'download-and-extract', 11:50:36 INFO - 'populate-webroot', 11:50:36 INFO - 'create-virtualenv', 11:50:36 INFO - 'install', 11:50:36 INFO - 'run-tests'), 11:50:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:50:36 INFO - 'download_minidump_stackwalk': True, 11:50:36 INFO - 'download_symbols': 'ondemand', 11:50:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:50:36 INFO - 'tooltool.py': '/tools/tooltool.py', 11:50:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:50:36 INFO - '/tools/misc-python/virtualenv.py')}, 11:50:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:50:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:50:36 INFO - 'installer_path': 'installer.exe', 11:50:36 INFO - 'log_level': 'info', 11:50:36 INFO - 'log_name': 'talos', 11:50:36 INFO - 'log_to_console': True, 11:50:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:50:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:50:36 INFO - 'opt_config_files': (), 11:50:36 INFO - 'pip_index': False, 11:50:36 INFO - 'sps_profile': False, 11:50:36 INFO - 'sps_profile_interval': 0, 11:50:36 INFO - 'suite': 'dromaeojs', 11:50:36 INFO - 'system_bits': '64', 11:50:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:50:36 INFO - 'title': 'talos-linux64-ix-018', 11:50:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:50:36 INFO - 'use_talos_json': True, 11:50:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:50:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:50:36 INFO - 'work_dir': 'build'} 11:50:36 INFO - ##### 11:50:36 INFO - ##### Running clobber step. 11:50:36 INFO - ##### 11:50:36 INFO - Running pre-action listener: _resource_record_pre_action 11:50:36 INFO - Running main action method: clobber 11:50:36 INFO - rmtree: /builds/slave/test/build 11:50:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:50:36 INFO - Running post-action listener: _resource_record_post_action 11:50:36 INFO - ##### 11:50:36 INFO - ##### Running read-buildbot-config step. 11:50:36 INFO - ##### 11:50:36 INFO - Running pre-action listener: _resource_record_pre_action 11:50:36 INFO - Running main action method: read_buildbot_config 11:50:36 INFO - Using buildbot properties: 11:50:36 INFO - { 11:50:36 INFO - "project": "", 11:50:36 INFO - "product": "firefox", 11:50:36 INFO - "script_repo_revision": "production", 11:50:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:50:36 INFO - "repository": "", 11:50:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:50:36 INFO - "buildid": "20151217111251", 11:50:36 INFO - "pgo_build": "False", 11:50:36 INFO - "basedir": "/builds/slave/test", 11:50:36 INFO - "buildnumber": 1025, 11:50:36 INFO - "slavename": "talos-linux64-ix-018", 11:50:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:50:36 INFO - "platform": "ubuntu64_hw", 11:50:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:50:36 INFO - "branch": "fx-team", 11:50:36 INFO - "repo_path": "integration/fx-team", 11:50:36 INFO - "revision": "6a2ad662612370d248530465d690785c20abcf0b", 11:50:36 INFO - "stage_platform": "linux64", 11:50:36 INFO - "builduid": "8db484571edd4e8bafa68a6de5cde574", 11:50:36 INFO - "slavebuilddir": "test" 11:50:36 INFO - } 11:50:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 11:50:36 INFO - Running post-action listener: _resource_record_post_action 11:50:36 INFO - ##### 11:50:36 INFO - ##### Running download-and-extract step. 11:50:36 INFO - ##### 11:50:36 INFO - Running pre-action listener: _resource_record_pre_action 11:50:36 INFO - Running main action method: download_and_extract 11:50:36 INFO - mkdir: /builds/slave/test/build/tests 11:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:36 INFO - https://queue.taskcluster.net/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:50:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/test_packages.json 11:50:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/test_packages.json 11:50:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:50:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:50:39 INFO - Downloaded 1302 bytes. 11:50:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:50:39 INFO - Using the following test package requirements: 11:50:39 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:50:39 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:50:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:50:39 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:50:39 INFO - u'jsshell-linux-x86_64.zip'], 11:50:39 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:50:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:50:39 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:50:39 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:50:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:50:39 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:50:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:50:39 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:50:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:50:39 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:50:39 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:50:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:50:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:50: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')]} 11:50:39 INFO - https://queue.taskcluster.net/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:50:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:50:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:50:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:50:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:50:41 INFO - Downloaded 21870957 bytes. 11:50:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:50:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:50:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:50:42 INFO - Return code: 0 11:50:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:50:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:42 INFO - https://queue.taskcluster.net/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:50:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:50:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:50:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:50:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:50:45 INFO - Downloaded 21870957 bytes. 11:50:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:50:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:50:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:50:46 INFO - Return code: 0 11:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:46 INFO - https://queue.taskcluster.net/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:50:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:50:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:50:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:50:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:50:49 INFO - Downloaded 11132039 bytes. 11:50:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 11:50:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:50:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:50:49 INFO - Return code: 0 11:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:49 INFO - https://queue.taskcluster.net/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:50:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:50:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:50:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:50:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:50:52 INFO - Downloaded 53017850 bytes. 11:50:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:50:52 INFO - mkdir: /builds/slave/test/properties 11:50:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:50:52 INFO - Writing to file /builds/slave/test/properties/build_url 11:50:52 INFO - Contents: 11:50:52 INFO - build_url:https://queue.taskcluster.net/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:50:52 INFO - Running post-action listener: _resource_record_post_action 11:50:52 INFO - Running post-action listener: set_extra_try_arguments 11:50:52 INFO - ##### 11:50:52 INFO - ##### Running populate-webroot step. 11:50:52 INFO - ##### 11:50:52 INFO - Running pre-action listener: _resource_record_pre_action 11:50:52 INFO - Running main action method: populate_webroot 11:50:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:50:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:50:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:50:52 INFO - '--tppagecycles', 11:50:52 INFO - '7'], 11:50:52 INFO - 'tests': ['tsvgm']}}, 11:50:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:50:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:50:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:50:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:50:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:50:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:50:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:50:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:50:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:50:52 INFO - 'talos_options': ['--e10s'], 11:50:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:50:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:50:52 INFO - 'tests': ['damp', 'tps']}, 11:50:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:50:52 INFO - 'talos_options': ['--e10s'], 11:50:52 INFO - 'tests': ['damp', 'tps']}, 11:50:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:50:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:50:52 INFO - 'other': {'tests': ['a11yr', 11:50:52 INFO - 'ts_paint', 11:50:52 INFO - 'tpaint', 11:50:52 INFO - 'sessionrestore', 11:50:52 INFO - 'sessionrestore_no_auto_restore']}, 11:50:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:50:52 INFO - 'tests': ['a11yr', 11:50:52 INFO - 'ts_paint', 11:50:52 INFO - 'tpaint', 11:50:52 INFO - 'sessionrestore', 11:50:52 INFO - 'sessionrestore_no_auto_restore']}, 11:50:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:50:52 INFO - 'tests': ['a11yr', 11:50:52 INFO - 'ts_paint', 11:50:52 INFO - 'tpaint', 11:50:52 INFO - 'sessionrestore', 11:50:52 INFO - 'sessionrestore_no_auto_restore']}, 11:50:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:50:52 INFO - 'tests': ['a11yr', 11:50:52 INFO - 'ts_paint', 11:50:52 INFO - 'tpaint', 11:50:52 INFO - 'sessionrestore', 11:50:52 INFO - 'sessionrestore_no_auto_restore']}, 11:50:52 INFO - 'other_l64': {'tests': ['a11yr', 11:50:52 INFO - 'ts_paint', 11:50:52 INFO - 'tpaint', 11:50:52 INFO - 'sessionrestore', 11:50:52 INFO - 'sessionrestore_no_auto_restore']}, 11:50:52 INFO - 'other_nol64': {'tests': ['a11yr', 11:50:52 INFO - 'ts_paint', 11:50:52 INFO - 'tpaint', 11:50:52 INFO - 'sessionrestore', 11:50:52 INFO - 'sessionrestore_no_auto_restore']}, 11:50:52 INFO - 'svgr': {'tests': ['tsvgx', 11:50:52 INFO - 'tsvgr_opacity', 11:50:52 INFO - 'tart', 11:50:52 INFO - 'tscrollx', 11:50:52 INFO - 'cart']}, 11:50:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:50:52 INFO - 'tests': ['tsvgx', 11:50:52 INFO - 'tsvgr_opacity', 11:50:52 INFO - 'tart', 11:50:52 INFO - 'tscrollx', 11:50:52 INFO - 'cart']}, 11:50:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:50:52 INFO - 'tests': ['tp5o']}, 11:50:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:50:52 INFO - 'talos_options': ['--e10s'], 11:50:52 INFO - 'tests': ['tp5o']}, 11:50:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:50:52 INFO - 'talos_options': ['--xperf_path', 11:50:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:50:52 INFO - 'tests': ['tp5n']}, 11:50:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:50:52 INFO - 'talos_options': ['--e10s', 11:50:52 INFO - '--xperf_path', 11:50:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:50:52 INFO - 'tests': ['tp5n']}}, 11:50:52 INFO - 'talos.zip': {'path': '', 11:50:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:50:52 INFO - Running post-action listener: _resource_record_post_action 11:50:52 INFO - ##### 11:50:52 INFO - ##### Running create-virtualenv step. 11:50:52 INFO - ##### 11:50:52 INFO - Running pre-action listener: _resource_record_pre_action 11:50:52 INFO - Running main action method: create_virtualenv 11:50:52 INFO - Creating virtualenv /builds/slave/test/build/venv 11:50: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 11:50:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:50:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:50:52 INFO - Using real prefix '/usr' 11:50:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:50:52 INFO - Installing distribute.............................................................................................................................................................................................done. 11:50:54 INFO - Installing pip.................done. 11:50:54 INFO - Return code: 0 11:50:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:54 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 0x7f4f15be0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24220b0>, '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 0x2422fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423440>, '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': '6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:50:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:50:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:50:54 INFO - Using env: {'DISPLAY': ':0', 11:50:54 INFO - 'HOME': '/home/cltbld', 11:50:54 INFO - 'LANG': 'en_US.UTF-8', 11:50:54 INFO - 'LANGUAGE': 'en_US:en', 11:50:54 INFO - 'LOGNAME': 'cltbld', 11:50:54 INFO - 'MAIL': '/var/mail/cltbld', 11:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:54 INFO - 'MOZ_NO_REMOTE': '1', 11:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:54 INFO - 'NO_EM_RESTART': '1', 11:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:54 INFO - 'PWD': '/builds/slave/test', 11:50:54 INFO - 'SHELL': '/bin/bash', 11:50:54 INFO - 'SHLVL': '1', 11:50:54 INFO - 'TERM': 'linux', 11:50:54 INFO - 'TMOUT': '86400', 11:50:54 INFO - 'USER': 'cltbld', 11:50:54 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947', 11:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:54 INFO - '_': '/tools/buildbot/bin/python'} 11:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50: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 11:50:55 INFO - Cleaning up... 11:50:55 INFO - Return code: 0 11:50:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:50: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')]} 11:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50: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')]} 11:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50: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 0x7f4f15be0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24220b0>, '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 0x2422fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423440>, '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': '6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:50: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 11:50: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 11:50:55 INFO - Using env: {'DISPLAY': ':0', 11:50:55 INFO - 'HOME': '/home/cltbld', 11:50:55 INFO - 'LANG': 'en_US.UTF-8', 11:50:55 INFO - 'LANGUAGE': 'en_US:en', 11:50:55 INFO - 'LOGNAME': 'cltbld', 11:50:55 INFO - 'MAIL': '/var/mail/cltbld', 11:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:55 INFO - 'MOZ_NO_REMOTE': '1', 11:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:55 INFO - 'NO_EM_RESTART': '1', 11:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:55 INFO - 'PWD': '/builds/slave/test', 11:50:55 INFO - 'SHELL': '/bin/bash', 11:50:55 INFO - 'SHLVL': '1', 11:50:55 INFO - 'TERM': 'linux', 11:50:55 INFO - 'TMOUT': '86400', 11:50:55 INFO - 'USER': 'cltbld', 11:50:55 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947', 11:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:55 INFO - '_': '/tools/buildbot/bin/python'} 11:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:55 INFO - Downloading/unpacking psutil>=0.7.1 11:50: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 11:50: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 11:50: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 11:50: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 11:50: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 11:50: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 11:50:56 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:50:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:50:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:50:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:50:57 INFO - Installing collected packages: psutil 11:50:57 INFO - Running setup.py install for psutil 11:50:57 INFO - building 'psutil._psutil_linux' extension 11:50: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 11:50: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 11:50:57 INFO - building 'psutil._psutil_posix' extension 11:50: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 11:50: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 11:50:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:50:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:50:57 INFO - Successfully installed psutil 11:50:57 INFO - Cleaning up... 11:50:57 INFO - Return code: 0 11:50:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:50: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')]} 11:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50: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')]} 11:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:57 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 0x7f4f15be0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24220b0>, '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 0x2422fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423440>, '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': '6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:50:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:50:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:50:57 INFO - Using env: {'DISPLAY': ':0', 11:50:57 INFO - 'HOME': '/home/cltbld', 11:50:57 INFO - 'LANG': 'en_US.UTF-8', 11:50:57 INFO - 'LANGUAGE': 'en_US:en', 11:50:57 INFO - 'LOGNAME': 'cltbld', 11:50:57 INFO - 'MAIL': '/var/mail/cltbld', 11:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:57 INFO - 'MOZ_NO_REMOTE': '1', 11:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:57 INFO - 'NO_EM_RESTART': '1', 11:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:57 INFO - 'PWD': '/builds/slave/test', 11:50:57 INFO - 'SHELL': '/bin/bash', 11:50:57 INFO - 'SHLVL': '1', 11:50:57 INFO - 'TERM': 'linux', 11:50:57 INFO - 'TMOUT': '86400', 11:50:57 INFO - 'USER': 'cltbld', 11:50:57 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947', 11:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:57 INFO - '_': '/tools/buildbot/bin/python'} 11:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:50:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:50: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) 11:50:59 INFO - Installing collected packages: mozsystemmonitor 11:50:59 INFO - Running setup.py install for mozsystemmonitor 11:50:59 INFO - Successfully installed mozsystemmonitor 11:50:59 INFO - Cleaning up... 11:50:59 INFO - Return code: 0 11:50:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4f15be0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24220b0>, '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 0x2422fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423440>, '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': '6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:50:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:50:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:50:59 INFO - Using env: {'DISPLAY': ':0', 11:50:59 INFO - 'HOME': '/home/cltbld', 11:50:59 INFO - 'LANG': 'en_US.UTF-8', 11:50:59 INFO - 'LANGUAGE': 'en_US:en', 11:50:59 INFO - 'LOGNAME': 'cltbld', 11:50:59 INFO - 'MAIL': '/var/mail/cltbld', 11:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:59 INFO - 'MOZ_NO_REMOTE': '1', 11:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:59 INFO - 'NO_EM_RESTART': '1', 11:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:59 INFO - 'PWD': '/builds/slave/test', 11:50:59 INFO - 'SHELL': '/bin/bash', 11:50:59 INFO - 'SHLVL': '1', 11:50:59 INFO - 'TERM': 'linux', 11:50:59 INFO - 'TMOUT': '86400', 11:50:59 INFO - 'USER': 'cltbld', 11:50:59 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947', 11:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:59 INFO - '_': '/tools/buildbot/bin/python'} 11:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:59 INFO - Downloading/unpacking blobuploader==1.2.4 11:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:01 INFO - Downloading blobuploader-1.2.4.tar.gz 11:51:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:51:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:51:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51:02 INFO - Downloading docopt-0.6.1.tar.gz 11:51:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:51:02 INFO - Installing collected packages: blobuploader, requests, docopt 11:51:02 INFO - Running setup.py install for blobuploader 11:51:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:51:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:51:02 INFO - Running setup.py install for requests 11:51:02 INFO - Running setup.py install for docopt 11:51:02 INFO - Successfully installed blobuploader requests docopt 11:51:02 INFO - Cleaning up... 11:51:02 INFO - Return code: 0 11:51:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:02 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 0x7f4f15be0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24220b0>, '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 0x2422fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423440>, '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': '6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:51:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:51:02 INFO - Using env: {'DISPLAY': ':0', 11:51:02 INFO - 'HOME': '/home/cltbld', 11:51:02 INFO - 'LANG': 'en_US.UTF-8', 11:51:02 INFO - 'LANGUAGE': 'en_US:en', 11:51:02 INFO - 'LOGNAME': 'cltbld', 11:51:02 INFO - 'MAIL': '/var/mail/cltbld', 11:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:02 INFO - 'MOZ_NO_REMOTE': '1', 11:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:02 INFO - 'NO_EM_RESTART': '1', 11:51:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:02 INFO - 'PWD': '/builds/slave/test', 11:51:02 INFO - 'SHELL': '/bin/bash', 11:51:02 INFO - 'SHLVL': '1', 11:51:02 INFO - 'TERM': 'linux', 11:51:02 INFO - 'TMOUT': '86400', 11:51:02 INFO - 'USER': 'cltbld', 11:51:02 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947', 11:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:02 INFO - '_': '/tools/buildbot/bin/python'} 11:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:51:03 INFO - Running setup.py (path:/tmp/pip-1dGSFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:51:03 INFO - Running setup.py (path:/tmp/pip-q8YXw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:51:03 INFO - Running setup.py (path:/tmp/pip-Ahj5eC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:51:03 INFO - Running setup.py (path:/tmp/pip-iMEfnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:51:03 INFO - Running setup.py (path:/tmp/pip-IAIKR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:51:03 INFO - Running setup.py (path:/tmp/pip-A0gBk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:51:03 INFO - Running setup.py (path:/tmp/pip-H1DVhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:51:03 INFO - Running setup.py (path:/tmp/pip-_G84kZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:51:03 INFO - Running setup.py (path:/tmp/pip-P426Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:51:03 INFO - Running setup.py (path:/tmp/pip-y5xM9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:51:03 INFO - Running setup.py (path:/tmp/pip-JiV6A_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:51:03 INFO - Running setup.py (path:/tmp/pip-tLAG4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:51:04 INFO - Running setup.py (path:/tmp/pip-ssuJfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:51:04 INFO - Running setup.py (path:/tmp/pip-56fmBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:04 INFO - Running setup.py (path:/tmp/pip-eT2wT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:51:04 INFO - Running setup.py (path:/tmp/pip-Fx4XEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:51:04 INFO - Running setup.py (path:/tmp/pip-I3s8FZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:51:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:51:04 INFO - Running setup.py install for manifestparser 11:51:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:51:04 INFO - Running setup.py install for mozcrash 11:51:04 INFO - Running setup.py install for mozdebug 11:51:04 INFO - Running setup.py install for mozdevice 11:51:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:51:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:51:04 INFO - Running setup.py install for mozfile 11:51:04 INFO - Running setup.py install for mozhttpd 11:51:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:51:04 INFO - Running setup.py install for mozinfo 11:51:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:51:05 INFO - Running setup.py install for mozInstall 11:51:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:51:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:51:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:51:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:51:05 INFO - Running setup.py install for mozleak 11:51:05 INFO - Running setup.py install for mozlog 11:51:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:51:05 INFO - Running setup.py install for moznetwork 11:51:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:51:05 INFO - Running setup.py install for mozprocess 11:51:05 INFO - Running setup.py install for mozprofile 11:51:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:51:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:51:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:51:05 INFO - Running setup.py install for mozrunner 11:51:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:51:05 INFO - Running setup.py install for mozscreenshot 11:51:05 INFO - Running setup.py install for moztest 11:51:06 INFO - Running setup.py install for mozversion 11:51:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:51:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:51:06 INFO - Cleaning up... 11:51:06 INFO - Return code: 0 11:51:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51: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')]} 11:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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')]} 11:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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 0x7f4f15be0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24220b0>, '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 0x2422fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423440>, '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': '6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:51: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 11:51: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 11:51:06 INFO - Using env: {'DISPLAY': ':0', 11:51:06 INFO - 'HOME': '/home/cltbld', 11:51:06 INFO - 'LANG': 'en_US.UTF-8', 11:51:06 INFO - 'LANGUAGE': 'en_US:en', 11:51:06 INFO - 'LOGNAME': 'cltbld', 11:51:06 INFO - 'MAIL': '/var/mail/cltbld', 11:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:06 INFO - 'MOZ_NO_REMOTE': '1', 11:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:06 INFO - 'NO_EM_RESTART': '1', 11:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:06 INFO - 'PWD': '/builds/slave/test', 11:51:06 INFO - 'SHELL': '/bin/bash', 11:51:06 INFO - 'SHLVL': '1', 11:51:06 INFO - 'TERM': 'linux', 11:51:06 INFO - 'TMOUT': '86400', 11:51:06 INFO - 'USER': 'cltbld', 11:51:06 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947', 11:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:06 INFO - '_': '/tools/buildbot/bin/python'} 11:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:51:06 INFO - Running setup.py (path:/tmp/pip-trT189-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:51: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)) 11:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:51:06 INFO - Running setup.py (path:/tmp/pip-XYiVuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:51: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)) 11:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:51:06 INFO - Running setup.py (path:/tmp/pip-Zc9sjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:51: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)) 11:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:51:06 INFO - Running setup.py (path:/tmp/pip-jAPPqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:51:06 INFO - Running setup.py (path:/tmp/pip-3QuAR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:51:06 INFO - Running setup.py (path:/tmp/pip-YesOXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:51:06 INFO - Running setup.py (path:/tmp/pip-gfZecr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:51:06 INFO - Running setup.py (path:/tmp/pip-jEsEOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:51:06 INFO - Running setup.py (path:/tmp/pip-0EQld0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:51:07 INFO - Running setup.py (path:/tmp/pip-_dndyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:51: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)) 11:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:51:07 INFO - Running setup.py (path:/tmp/pip-se_kyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:51: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)) 11:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:51:07 INFO - Running setup.py (path:/tmp/pip-X5Ga71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:51: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)) 11:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:51:07 INFO - Running setup.py (path:/tmp/pip-lu9Cj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:51: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)) 11:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:51:07 INFO - Running setup.py (path:/tmp/pip-CbcA8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:51: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)) 11:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:07 INFO - Running setup.py (path:/tmp/pip-ZBufJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:51: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)) 11:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:51:07 INFO - Running setup.py (path:/tmp/pip-3XBU2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:51: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)) 11:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:51:07 INFO - Running setup.py (path:/tmp/pip-vtZhzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:51:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:09 INFO - Downloading blessings-1.5.1.tar.gz 11:51: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 11:51:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:51:09 INFO - Installing collected packages: blessings 11:51:09 INFO - Running setup.py install for blessings 11:51:09 INFO - Successfully installed blessings 11:51:09 INFO - Cleaning up... 11:51:09 INFO - Return code: 0 11:51:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:51:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:51:09 INFO - Reading from file tmpfile_stdout 11:51:09 INFO - Current package versions: 11:51:09 INFO - argparse == 1.2.1 11:51:09 INFO - blessings == 1.5.1 11:51:09 INFO - blobuploader == 1.2.4 11:51:09 INFO - docopt == 0.6.1 11:51:09 INFO - manifestparser == 1.1 11:51:09 INFO - mozInstall == 1.12 11:51:09 INFO - mozcrash == 0.16 11:51:09 INFO - mozdebug == 0.1 11:51:09 INFO - mozdevice == 0.47 11:51:09 INFO - mozfile == 1.2 11:51:09 INFO - mozhttpd == 0.7 11:51:09 INFO - mozinfo == 0.9 11:51:09 INFO - mozleak == 0.1 11:51:09 INFO - mozlog == 3.1 11:51:09 INFO - moznetwork == 0.27 11:51:09 INFO - mozprocess == 0.22 11:51:09 INFO - mozprofile == 0.27 11:51:09 INFO - mozrunner == 6.11 11:51:09 INFO - mozscreenshot == 0.1 11:51:09 INFO - mozsystemmonitor == 0.0 11:51:09 INFO - moztest == 0.7 11:51:09 INFO - mozversion == 1.4 11:51:09 INFO - psutil == 3.1.1 11:51:09 INFO - requests == 1.2.3 11:51:09 INFO - wsgiref == 0.1.2 11:51:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:09 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 0x7f4f15be0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24220b0>, '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 0x2422fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423440>, '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': '6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:51:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:51:09 INFO - Using env: {'DISPLAY': ':0', 11:51:09 INFO - 'HOME': '/home/cltbld', 11:51:09 INFO - 'LANG': 'en_US.UTF-8', 11:51:09 INFO - 'LANGUAGE': 'en_US:en', 11:51:09 INFO - 'LOGNAME': 'cltbld', 11:51:09 INFO - 'MAIL': '/var/mail/cltbld', 11:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:09 INFO - 'MOZ_NO_REMOTE': '1', 11:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:09 INFO - 'NO_EM_RESTART': '1', 11:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:09 INFO - 'PWD': '/builds/slave/test', 11:51:09 INFO - 'SHELL': '/bin/bash', 11:51:09 INFO - 'SHLVL': '1', 11:51:09 INFO - 'TERM': 'linux', 11:51:09 INFO - 'TMOUT': '86400', 11:51:09 INFO - 'USER': 'cltbld', 11:51:09 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947', 11:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:09 INFO - '_': '/tools/buildbot/bin/python'} 11:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:51:09 INFO - Cleaning up... 11:51:09 INFO - Return code: 0 11:51:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:09 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 0x7f4f15be0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24220b0>, '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 0x2422fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423440>, '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': '6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:51:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:51:09 INFO - Using env: {'DISPLAY': ':0', 11:51:09 INFO - 'HOME': '/home/cltbld', 11:51:09 INFO - 'LANG': 'en_US.UTF-8', 11:51:09 INFO - 'LANGUAGE': 'en_US:en', 11:51:09 INFO - 'LOGNAME': 'cltbld', 11:51:09 INFO - 'MAIL': '/var/mail/cltbld', 11:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:09 INFO - 'MOZ_NO_REMOTE': '1', 11:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:09 INFO - 'NO_EM_RESTART': '1', 11:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:09 INFO - 'PWD': '/builds/slave/test', 11:51:09 INFO - 'SHELL': '/bin/bash', 11:51:09 INFO - 'SHLVL': '1', 11:51:09 INFO - 'TERM': 'linux', 11:51:09 INFO - 'TMOUT': '86400', 11:51:09 INFO - 'USER': 'cltbld', 11:51:09 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947', 11:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:09 INFO - '_': '/tools/buildbot/bin/python'} 11:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:10 INFO - Downloading/unpacking jsonschema 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:51:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 11:51:11 INFO - Downloading/unpacking functools32 (from jsonschema) 11:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:12 INFO - Downloading functools32-3.2.3-2.tar.gz 11:51: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 11:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:51:12 INFO - warning: no files found matching '*.txt' 11:51:12 INFO - no previously-included directories found matching 'build' 11:51:12 INFO - no previously-included directories found matching 'dist' 11:51:12 INFO - no previously-included directories found matching '.git*' 11:51:12 INFO - Installing collected packages: jsonschema, functools32 11:51:12 INFO - Running setup.py install for functools32 11:51:12 INFO - warning: no files found matching '*.txt' 11:51:12 INFO - no previously-included directories found matching 'build' 11:51:12 INFO - no previously-included directories found matching 'dist' 11:51:12 INFO - no previously-included directories found matching '.git*' 11:51:12 INFO - Successfully installed jsonschema functools32 11:51:12 INFO - Cleaning up... 11:51:12 INFO - Return code: 0 11:51:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:51: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')]} 11:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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')]} 11:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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 0x7f4f15be0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24220b0>, '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 0x2422fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423440>, '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': '6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:51: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 11:51: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 11:51:12 INFO - Using env: {'DISPLAY': ':0', 11:51:12 INFO - 'HOME': '/home/cltbld', 11:51:12 INFO - 'LANG': 'en_US.UTF-8', 11:51:12 INFO - 'LANGUAGE': 'en_US:en', 11:51:12 INFO - 'LOGNAME': 'cltbld', 11:51:12 INFO - 'MAIL': '/var/mail/cltbld', 11:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:12 INFO - 'MOZ_NO_REMOTE': '1', 11:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:12 INFO - 'NO_EM_RESTART': '1', 11:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:12 INFO - 'PWD': '/builds/slave/test', 11:51:12 INFO - 'SHELL': '/bin/bash', 11:51:12 INFO - 'SHLVL': '1', 11:51:12 INFO - 'TERM': 'linux', 11:51:12 INFO - 'TMOUT': '86400', 11:51:12 INFO - 'USER': 'cltbld', 11:51:12 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947', 11:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:12 INFO - '_': '/tools/buildbot/bin/python'} 11:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:12 INFO - Downloading/unpacking flake8 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:51: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 11:51:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:51: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 11:51:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:51:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:51:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:51:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:51:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:51:14 INFO - no previously-included directories found matching 'docs/_build' 11:51:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:51:14 INFO - Running setup.py install for pep8 11:51:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:51:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:51:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:51:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:51:14 INFO - no previously-included directories found matching 'docs/_build' 11:51:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:51:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:51:15 INFO - Cleaning up... 11:51:15 INFO - Return code: 0 11:51:15 INFO - Running post-action listener: _resource_record_post_action 11:51:15 INFO - Running post-action listener: _start_resource_monitoring 11:51:15 INFO - Starting resource monitoring. 11:51:15 INFO - ##### 11:51:15 INFO - ##### Running install step. 11:51:15 INFO - ##### 11:51:15 INFO - Running pre-action listener: _resource_record_pre_action 11:51:15 INFO - Running main action method: install 11:51:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:51:15 INFO - Reading from file tmpfile_stdout 11:51:15 INFO - Detecting whether we're running mozinstall >=1.0... 11:51:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:51:15 INFO - Reading from file tmpfile_stdout 11:51:15 INFO - Output received: 11:51:15 INFO - Usage: mozinstall [options] installer 11:51:15 INFO - Options: 11:51:15 INFO - -h, --help show this help message and exit 11:51:15 INFO - -d DEST, --destination=DEST 11:51:15 INFO - Directory to install application into. [default: 11:51:15 INFO - "/builds/slave/test"] 11:51:15 INFO - --app=APP Application being installed. [default: firefox] 11:51:15 INFO - mkdir: /builds/slave/test/build/application 11:51: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'] 11:51: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 11:51:30 INFO - Reading from file tmpfile_stdout 11:51:30 INFO - Output received: 11:51:30 INFO - /builds/slave/test/build/application/firefox/firefox 11:51:30 INFO - Running post-action listener: _resource_record_post_action 11:51:30 INFO - ##### 11:51:30 INFO - ##### Running run-tests step. 11:51:30 INFO - ##### 11:51:30 INFO - Running pre-action listener: _resource_record_pre_action 11:51:30 INFO - Running main action method: run_tests 11:51:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:51:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:51:30 INFO - Python 2.7.3 11:51:30 INFO - Return code: 0 11:51:30 INFO - grabbing minidump binary from tooltool 11:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51: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 0x24220b0>, '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 0x2422fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:51: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 11:51: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 11:51:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:51:30 INFO - Return code: 0 11:51:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:51:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:51:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:51:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:51:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:51:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:51:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:51:31 INFO - Return code: 0 11:51: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/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] in /builds/slave/test/build 11:51: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/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost 11:51:31 INFO - Using env: {'DISPLAY': ':0', 11:51:31 INFO - 'HOME': '/home/cltbld', 11:51:31 INFO - 'LANG': 'en_US.UTF-8', 11:51:31 INFO - 'LANGUAGE': 'en_US:en', 11:51:31 INFO - 'LOGNAME': 'cltbld', 11:51:31 INFO - 'MAIL': '/var/mail/cltbld', 11:51:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:51:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:31 INFO - 'MOZ_NO_REMOTE': '1', 11:51:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:31 INFO - 'NO_EM_RESTART': '1', 11:51:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:31 INFO - 'PWD': '/builds/slave/test', 11:51:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:51:31 INFO - 'SHELL': '/bin/bash', 11:51:31 INFO - 'SHLVL': '1', 11:51:31 INFO - 'TERM': 'linux', 11:51:31 INFO - 'TMOUT': '86400', 11:51:31 INFO - 'USER': 'cltbld', 11:51:31 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947', 11:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:31 INFO - '_': '/tools/buildbot/bin/python'} 11:51: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/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] with output_timeout 3600 11:51:31 INFO - mozversion INFO | application_buildid: 20151217111251 11:51:31 INFO - mozversion INFO | application_changeset: 6a2ad662612370d248530465d690785c20abcf0b 11:51:31 INFO - mozversion INFO | application_display_name: Nightly 11:51:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:51:31 INFO - mozversion INFO | application_name: Firefox 11:51:31 INFO - mozversion INFO | application_remotingname: firefox 11:51:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:51:31 INFO - mozversion INFO | application_vendor: Mozilla 11:51:31 INFO - mozversion INFO | application_version: 46.0a1 11:51:31 INFO - mozversion INFO | platform_buildid: 20151217111251 11:51:31 INFO - mozversion INFO | platform_changeset: 6a2ad662612370d248530465d690785c20abcf0b 11:51:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:51:31 INFO - mozversion INFO | platform_version: 46.0a1 11:51:31 INFO - 2015-12-17 11:51:31,970 DEBUG : using testdate: 1450381891 11:51:31 INFO - 2015-12-17 11:51:31,970 DEBUG : actual date: 1450381891 11:51:31 INFO - 2015-12-17 11:51:31,979 INFO : starting webserver on 'localhost:35658' 11:51:31 INFO - 2015-12-17 11:51:31,980 INFO : Starting test suite talos-linux64-ix-018 11:51:31 INFO - 2015-12-17 11:51:31,980 INFO : Starting test dromaeo_css 11:51:31 INFO - 2015-12-17 11:51:31,981 DEBUG : operating with platform_type : linux_ 11:51:31 INFO - 2015-12-17 11:51:31,981 INFO : Initialising browser for dromaeo_css test... 11:51:31 INFO - 2015-12-17 11:51:31,995 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuK2Z6w/profile http://localhost:35658/getInfo.html 11:51:36 INFO - 2015-12-17 11:51:36,299 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:51:36 INFO - 2015-12-17 11:51:36,299 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:51:36 INFO - 2015-12-17 11:51:36,299 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:51:36 INFO - 2015-12-17 11:51:36,299 DEBUG : BROWSER_OUTPUT: __metrics 11:51:36 INFO - 2015-12-17 11:51:36,376 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:51:36 INFO - 2015-12-17 11:51:36,444 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] 11:51:36 ERROR - 2015-12-17 11:51:36,460 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 11:51:37 INFO - 2015-12-17 11:51:37,515 INFO : Browser initialized. 11:51:37 INFO - 2015-12-17 11:51:37,515 INFO : Running cycle 1/1 for dromaeo_css test... 11:51:37 INFO - 2015-12-17 11:51:37,516 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuK2Z6w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:51:49 INFO - 2015-12-17 11:51:49,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 149995520 11:51:49 INFO - 2015-12-17 11:51:49,488 DEBUG : BROWSER_OUTPUT: 11:52:40 INFO - 2015-12-17 11:52:40,913 DEBUG : BROWSER_OUTPUT: 1450381960909 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:54:52 INFO - 2015-12-17 11:54:52,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35658/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35658/tests/dromaeo/cssquery-ext.html) 11:54:54 INFO - 2015-12-17 11:54:54,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 254205952 11:54:54 INFO - 2015-12-17 11:54:54,162 DEBUG : BROWSER_OUTPUT: 11:57:56 INFO - 2015-12-17 11:57:56,728 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35658/tests/dromaeo/cssquery-ext.html (next: http://localhost:35658/tests/dromaeo/cssquery-jquery.html) 11:57:57 INFO - 2015-12-17 11:57:57,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 231391232 11:57:57 INFO - 2015-12-17 11:57:57,301 DEBUG : BROWSER_OUTPUT: 12:00:59 INFO - 2015-12-17 12:00:59,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35658/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35658/tests/dromaeo/cssquery-mootools.html) 12:00:59 INFO - 2015-12-17 12:00:59,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 234745856 12:00:59 INFO - 2015-12-17 12:00:59,919 DEBUG : BROWSER_OUTPUT: 12:04:01 INFO - 2015-12-17 12:04:01,831 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35658/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35658/tests/dromaeo/cssquery-prototype.html) 12:04:02 INFO - 2015-12-17 12:04:02,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 214634496 12:04:02 INFO - 2015-12-17 12:04:02,412 DEBUG : BROWSER_OUTPUT: 12:07:05 INFO - 2015-12-17 12:07:05,211 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35658/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35658/tests/dromaeo/cssquery-yui.html) 12:07:05 INFO - 2015-12-17 12:07:05,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 190738432 12:07:05 INFO - 2015-12-17 12:07:05,797 DEBUG : BROWSER_OUTPUT: 12:10:08 INFO - 2015-12-17 12:10:08,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35658/tests/dromaeo/cssquery-yui.html (next: http://localhost:35658/tests/dromaeo/cssquery-dojo.html) 12:10:08 INFO - 2015-12-17 12:10:08,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 259919872 12:10:08 INFO - 2015-12-17 12:10:08,505 DEBUG : BROWSER_OUTPUT: 12:10:08 INFO - 2015-12-17 12:10:08,505 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:10:08 INFO - 2015-12-17 12:10:08,505 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:10:08 INFO - 2015-12-17 12:10:08,506 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:10:08 INFO - 2015-12-17 12:10:08,506 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:10:08 INFO - 2015-12-17 12:10:08,506 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2629.6975847777503;2721.0748345562506;2723.0061027724873;2732.357895894466;2745.4646343962922;4569.794359253841;4720.291956206566;4748.050389922012;4752;4774.8806279842975;4653.092646933849;4662.277347011211;4754.477007529169;4763.4522029966565;4794.856154315367;4312.978435107836;4318.395424640545;4364.345348197764;4490.820367185325;4507.504174540798;4423.601875831175;4466.7766611669285;4502.122086193193;4509.413776209105;4533.2066888294585;4214.304639734455;4266.274733295348;4318.395424640553;4329.480462344507;4355.194289056535;4362.956370436286;4369.934450983238;4386.780660966939;4393.319035549495;4413.227685155117;4339.5443478434945;4362.47650281965;4365.694401391872;4383.3863259143745;4397.5602439756085;4533.252013417782;4626.699264547828;4652;4666.836660716858;4759.952400475986;5021.924671129936;5022.573081288095;5030.094582975063;5031.899362012739;5082.949170508285;5041;5052.646314757969;5053.4946505349535;5112.079825631385;5119.155339368999;4521.706089104197;4639.582437580567;4642;4648.581627653527;4680.625549955996;5270.92093618596;5274.657147285414;5287.4976877196605;5316.122839731478;5331.306930099062;5050.116229659795;5053.84838454847;5060.342155519759;5063.0380227756605;5127.307813445212;4840.636952228527;4962.478939711351;4962.553370196628;4978.5270399312;5156.639035267495;5051.595872330205;5082.491750824962;5086.720230387365;5108.259302401131;5125.051865404912;5063.924041139386;5075.289459475676;5077.974610126926;5082.923756143661;5113.821016264487;4012.1775036117524;4058.817353219112;4101.835926562963;4159.9376009359885;4293.355996600535;3663.5420572428447;3664.193877346979;3678.7424880258127;3697.8335974881193;3720.311742327678;4331.198728235287;4332.740035597874;4337.631301339358;4367.213901497697;4370.694051416434;4822.758862056883;4936;4938;5035;5070.822521211814;4307.073979094447;4307.418498502662;4312.956870431255;4325.9134817303475;4346.978265108654;4441.578050085237;4441.666874984389;4443.511213766483;4445.5109937907455;4499.707519011319;4602.194615942263;4744.9051018978735;4750.548697873696;4751.619870410428;4810.182269014206;5120.078385890575;5121.283020377075;5131.923021154611;5147.845564632918;5176.896462070662;4843.370361852936;4848.369711937426;4850.563449289581;4850.636202284913;4887.095887260868;4795.808167673254;4882;5052.772625231947;5058.367704036996;5103.387593488805;4994.925076123788;5016.172331565397;5123.38519377677;5132.563732082815;5168.508991645787;4897.240927656219;4900.828471003498;4904.705717656952;4907.55831975124;4952.405711314521;4660.4174478190225;4848.393950756155;4909.95090049095;4914.631402644744;4965.726885021359;4764.714117152982;4782.330473733749;4882.755862206946;4901.921577252999;4915.0415668944215;5051.015052064812;5051.747412629427;5052.8484145475695;5060.063888180698;5063.240513922941;4931.211006238985;4949;4951.72765497901;4954.355933728592;4997.575206107522 12:10:08 INFO - 2015-12-17 12:10:08,507 DEBUG : BROWSER_OUTPUT: |1;ext.html;550.6558400999373;565.0958466453675;565.67473702621;568.5309619563861;572.6506830833191;25353;25997.48005039898;34885.65114348859;35530.644693553055;35545;40260.16227646989;40657.7967110164;40725;40869;40967.79516102415;7059.682314295844;7831.3343365813835;7949.761507154794;8011;8015.1984801519675;7203.207647158808;10007.09936105754;10353.275270731052;10357.223208259373;10370.585176592966;10035.899641003605;10107.444090575053;10115.443650599214;10117.645882394118;10118.13995810357;7256.8548629027655;7457.738979135758;10019.499025048755;10110.545025473797;10137.949310253438;9746;9908.157806586449;9912.55393507294;9917.801643967152;9923.503824808731;37308.44037339442;37708.811455942545;37775;37886;37944.62055379466;2591.4687489064695;2647.7484638959268;2714.3485563464824;2778.9444211115865;2866.942661146786;26630;27106.322341941413;27179.184624461297;27548.449031019467;27586;3234.5956755405573;3346.297277571713;3353.429916914106;3397.2356219850335;3415.3852306584804;214714;216422;216534;217000;217984;52411.73794131005;53468.78171446805;56003;56366.71816640891;56439.43560564424;60866.391336086956;61220.38779612147;61293;61324.38675613187;61326.69336653377;11330;11409.942950285196;11456.885431145749;11474.942625286987;11513.53945842157;8593.183647553473;8608.569571521399;8616.310695144373;8621.267192288726;8656.69701560455;18552.536186595444;18616.162272697762;18624.44126676202;19525.218991240476;19539.21843126259;7465.6267186641535;7658.2341765824085;7720;7789.844203115906;7825.530468171928;851.0935853316198;857.2456238510072;867.6139118092515;870.1385628228135;947.5877993073035;26373.34066648311;26511.867440662674;26726.465470690477;26839.463210736067;26855.328616784347;860.7934095817084;884.8053428245776;920.0661328751323;934.6822080492665;951.7002144324516;13150.145240559334;13369.131006484547;13453.730925381633;13526.18842869431;13614.727705445835;323889;328263;328378;328773;329656;46753.76623116863;46988.5301146991;47144.7642761784;47171.76414117976;47184.29223561649;1174.7298121432118;1180.887815657511;1190.898773604236;1192.403798100967;1192.9403529823473;24234.757652423956;24945.625815613144;25429;25449.61825572655;25501;36893.81553092218;37560.624393755716;37563.436548451245;37570.24859502849;37596.436053458674;252064;253699;253785;254307;254998;24532;24821;28195.43609127847;28612.856935715186;29440.55839162457;32887.671123289416;33089.33821323608;46084.769576151906;47297.52702473069;47666.52333476621;32754.34491310113;33335.83332083324;33469.33061338808;33587.664123359435;33635.831820840736;30393.24016899595;38350.61649383471;38411.42382864315;39725.00687482836;40200.798996004836;33362.833185833915;33583.496247556795;33731.662683373834;33934.151646209044;34089.318213636085;29232.41535169327;29910.551341730326;30451.39097217999;30508.847455763465;30605.693943061175;23513.88243058774;23712.52574948457;23763.405914851577;23783.405414864766;23863.76136238685 12:10:08 INFO - 2015-12-17 12:10:08,511 DEBUG : BROWSER_OUTPUT: |2;jquery.html;315.4322220003995;318.077575032406;322.21379833206976;323.2677984365413;325.589756906298;12663.55677551286;12966.222026678382;15368;15959.840401595995;16024.759628605565;12192.695182620439;14255.643608909782;15412.537623871274;16145.354185832583;16185.676286474263;4868.707877527342;5029.47190544993;6452.064450654652;6667.433268172211;6676.599404035749;4118.588141185873;4238.618524332809;6434.260060093103;6671.066050752898;6703.262641109474;6539.77110801122;6547.77082802102;6559.983202603604;6582.736690532373;6596.175478065242;6455;6643.1363922690225;6644.136262285871;6668.433183179435;6683.13119294491;6227.3772622737815;6378.425941665226;6382.808515744488;6391.744330226786;6398.072279519443;21289.574208515744;21334.25330113454;21367.35897923065;21740.673889891663;21848.781512184833;1840.2730921286152;1840.6686796376646;1889.6787546117193;1900.515368581017;1905.3045638341905;13113.737725245537;13485.528006519724;13522.188668679812;13783.655408614764;14073.437062517487;1765.364468791247;1803.8737288389818;1828.7165489349172;1857.6284743051444;1857.7399164117035;60383;60481.39518604846;61567.69216153935;64842.675786621236;65138.34861651323;15194.468193613171;15258.618534536725;15297.770533441784;15310.311036003184;15310.540683779505;23082.7691723084;23110.19114331024;23363.182288619817;23402.882985585304;23418.765812342;7653.617319134021;7913.920860791433;7925.28672419485;7980.082290536547;7992.760217193493;6575.44108750752;6583.506237032242;6617.735290588419;6623.834404139839;6670.199576050808;7477.551346919094;7515.173330933593;7524.946507488956;7556.773296801105;7583.658735356922;2497.5878979968466;2890.118513853253;2898.4927637663322;2916.2855100500515;2931.6335458067742;834.7871292820292;837.7109897085496;906.8322360363222;949.0699114867468;970.7087873638021;13617.591472255848;14993.32530036151;15747.68504629901;15853.128077955593;16201.513954581382;857.6706105536393;885.6191837509932;897.9461232326081;905.6196397512929;913.9946059334811;9177.449353038839;9356.157945784777;9380.812383752287;9421.514039805315;9473.242140628734;472556;476737;494897;495488;496548.5172574114;68520.3147968514;68823.65588172027;70163.64918175376;71243;71794.64102679453;959.8656188133667;959.8704174936295;1062.8883967183335;1092.907102896247;1097.2757979733337;14614.707705846036;14686.339114739649;14878.479253226518;14921.552353429415;15125.39498420095;30042.399152017275;30329.090127295334;32854.507182391804;33742.13191878718;35297.823510882285;42241.78879105585;42455.575444245165;43171.78414107909;44277.55722442734;44328.556714432445;8457.83084338322;8788.868166977372;8969.865452018355;8974.730758077269;9066;10199.7450063749;10245.538950747085;10306.896931030593;10386.480675966322;10402.687919362432;12786.616401507597;13876.930615346859;13980.300984950509;14073.366698498798;14323.928380358031;13743.450261989408;13887.236202008582;14025;14213.289335533389;14275.286235688382;14139.36372863203;14208.147511149364;14255.928720356747;14548;14775.482858099915;8926.464412135292;8991.370604057653;9017.188453038996;9258.259339252978;9267.67563135287;10891.78216435651;13223.3388330585;13245.536406225736;13372.799408008694;13389.263590502616 12:10:08 INFO - 2015-12-17 12:10:08,511 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1193.5583833981427;1622.4240394659896;1690.062015581352;1710.6236627941848;1726.905020223888;6090.756369745211;6862.622555759432;7019.68411421486;7039.401650859671;7040.401565866901;7049.506534542584;7222.927770722291;7225.963870180642;7230.60231687257;7239.095113110861;2030.4822270321047;2074.274004098561;2074.4917495213695;2077.719507866434;2079.511314841011;2084.9478763030893;2096.3710886733993;2098.3495116513855;2130.7656157822626;2136.3590922723197;2030.1574846438784;2043.427840204745;2051.046263487478;2051.825594824442;2053.5790163016545;2037.623039737646;2044.601302745965;2056.23919149914;2062.1648232465727;2068.369147410039;2034.206659402834;2041.1529215375601;2081.1363284237173;2082.3648787119923;2082.4689704125353;7044.436445084381;7100.928990710078;7109.466789990772;7111.146662400493;7151.141862976424;4060.634542891154;4134.800907736752;4146.170765846843;4150.232207041707;4156.8129434175535;2629.184952664661;2639.6304517367585;2671.4523522677805;2677.1700772760314;2693.6902256240587;864.7967727584013;867.5141920524527;885.2165833237567;906.6554709210458;910.2354022620964;9358.859617105749;9365.625374984993;9407.717768466957;9408.764780880532;9416.62333506652;3690.7785532868115;3699.5560532736245;3753.268112717994;3759.793211373401;3766.9434958475645;8154.2253485918745;8154.347652187811;8192.713255036046;8192.918070819334;8198.713045043394;4074.694397920168;4089.9795501022304;4097.09863829957;4097.1191193893455;4099.118689481776;3180.9979856345176;3253.528238405418;3625.8005809680194;3784.848606055727;3787.450819631138;3338.9666103338654;3362.915927101793;3382;3390.8982730518123;3396.8301584920655;1078.8941335131553;1091.307020042279;1091.8143915534379;1097.1716354152722;1111.2610114273916;1152.5735477873072;1164.598213616301;1187.26389638423;1192.1357016163213;1209.5887398284626;6777.423918966943;6820.624865632438;6835.07726456922;6892.586444813327;6894.345037221557;387.554312540575;399.86204759357975;402.9879103626896;403.28819633347166;403.3808104559546;5194.584433245332;5263.105272103751;5277.445868183862;5278.9208161877605;5280.313559237275;8218;8301.709440169685;8408.117147699526;8626.792249085132;8628.180322869317;8430.494170349799;8479.406441549156;8524.957375213084;8534.829303413897;8548.529830859363;6573.572717773234;6612.140421745143;6710.798676039727;6735.191776986695;6739.157605299338;6751.662416879039;6862.691178896862;6866.038754574463;6886.276940921131;6895.172579290517;7831.960840195762;7845.725399610987;7851.646675899712;7877.212278772077;7991.880121798062;7950.7217247396065;8054.23484768946;8132.796680082809;8187.3040791531;8257.669693212445;5540.584456165723;5625.5218306442775;6008.8798224036145;6075.665838378932;6091.664958427152;6001.639901605918;6413.1021656969;6536.542442029012;6542.084108224757;6543.116679248431;6204.844878878064;6339.556231063966;6401.487880969605;6516.0551719999385;6581.736730530725;6260.467860231931;6363.077353783768;6395.360463953567;6516.446102081376;6584.670766461753;6590.1103351046995;6631.635260060743;6632;6633.336666333328;6643.269240383651;5751.626144300607;5773.1051686988585;5797.246357973437;5802.622829516068;5803.941960580509;5787.594868359174;5788;5814.534837212928;5817.127430885401;5819.6508209507565 12:10:08 INFO - 2015-12-17 12:10:08,511 DEBUG : BROWSER_OUTPUT: |4;prototype.html;293.9221106406802;300.4126931848237;302.74569361736144;310.03887947363165;312.3970736478598;5260.395054568721;5287.603429742765;5313.8937221255555;5359.919601205985;5385.138377859544;5224.242484839696;5227.4511176326505;5241.135212689902;5243.475652434755;5259.552938000265;3886.3198940185353;4110.568390319018;4130.8554200602985;4153.750774953497;4159.646430053449;3955.6835453163676;4084.9387259191135;4117.258893399187;4119.011437255052;4133.73130746502;4063.1873625274916;4071.5114186297687;4073.572274911136;4073.8574149904757;4084.836606535735;3876.457295978565;3943.38877473992;4009.2382447334912;4079.224947260011;4090.5704900985415;3641.672249497558;3642.581103173116;3643.034595832107;3660.249648821985;3665.138692407282;5097.209932460474;5098.617603679739;5102.285680004802;5118.283440318359;5118.846434606968;4744.786484608201;4744.928826067612;4750.976245118787;4753.215719406294;4753.548412900769;5416.593755468316;5534.529564986981;5536.778528858841;5540.728301396408;5542.168674698827;3947.842086316544;3958.8123562931005;3959.208158368338;3959.247742928834;3962.4650672159178;5747.0230060889335;5849.795257165979;5851.151583020481;5854.795082172103;5855.355910849803;4082.3876418537457;4085.325921222965;4085.5914408558906;4088.0801819590947;4089.7137200395687;3775.2072064866684;3912.8630497932436;4146.751194928314;4149.854755083618;4154.189932963043;4182.477190351206;4450.5104438511735;4589.58693717567;4604.355390245369;4712;5415;5542;5557.110862262019;5566.443355664482;5576.693281869536;1447.0811034992855;1470.6838029823639;1470.8308544517304;1471.3746657670447;1471.624735692413;997.1823105053786;1013.7769690668041;1018.9861088217123;1021.6168936648756;1029.552144817007;4881.292212629149;4889.095517329305;4892.09496243189;4895.779689913962;4895.877603059952;5745.741441635137;5771.192033115367;5772.249607551075;5774.249347584787;5779.797707080232;4881.731504767272;4890.706557606555;4897.240927656219;4898.485659005753;4903.141950158708;3043.7520616547554;3083.691630836898;3118.4075025745037;3120.422721796475;3126.9530957035663;5484.670919744828;5495.093309603951;5501.587380946445;5503.3120859892515;5504.0643090674685;5950.761969521171;5952.761889524457;5956.225690660186;5959.582829201914;5960.910586341209;5461.808836690697;5479.068558345091;5494.230807686847;5494.8076817312;5498.092814685532;5618.69097199658;5799.623024503394;5800.8259752207505;5802.82591522255;5807.9545681776;5628.943710562842;5651.491365777099;5655.971720141373;5666.660000399989;5667.121596152603;5477.178423236546;5478.8904221914545;5485.451454854483;5494.725263736717;5501.834944951658;4011.597650732357;4065.0650350418978;4100.507939047214;4101.159262351271;4106.958930410778;5750.913736294043;5774.307083150049;5777.653340799566;5781.248437703071;5787.36339002701;5527.585431092603;5533.557315414677;5536.7785288588;5538.529225015919;5555.8611034722835;5563.332400112013;5575.581831362745;5580.190872323572;5580.441955804387;5584.692841893735;5331.333583302087;5434.3207099112615;5454.236406903116;5457.645253058698;5461.726913654381;5428.6199966002005;5576.86057848557;5599.412061733459;5609.635373700697;5616.522595579421;5395.892082158256;5486.6982315973;5504.4495550444635;5516.862078448071;5517.282753242052 12:10:08 INFO - 2015-12-17 12:10:08,512 DEBUG : BROWSER_OUTPUT: |5;yui.html;641.1724295855278;668.5787953589238;696.3593493985533;732.4945787406689;738.7931379213823;10924.508397122128;11088.611898583551;11102.722431939206;11107.833382499259;12109.091818113633;12184.086193535475;12291.44688489018;12294.63116106516;12310.753784924296;12311.815322770166;625.2528228766625;633.0409429713987;796.8007998000514;801.4870482890955;813.0040700142338;795.5624406576388;799.4403917257914;806.6853926968487;806.7781360125983;807.588130053671;832.7210384521193;836.3351135847016;836.4019725895984;836.4939211776879;839.0728245288959;649.1982401733854;655.9672016399185;820.2822530285999;829.9626516806698;834.3158609939852;620.8758248350348;621.1490258346095;621.1645337021698;621.3227581935666;621.561798931752;9230.123138301851;9315.76710582234;9350.57922393494;9351;9359.578818953163;10024.398536087858;10371.688849334532;10473.79052418955;10602.46987650622;10643.787124257471;7695.4997925134685;7807.297343239079;8704.651813927436;8864.423812452234;9001.819963600692;2931.8973835915854;3040.0727778027695;3124.8125112493094;3126;3132.7180553750045;39250.607493925265;39628.80185599082;39638.60361396378;39688.4046739302;39717.80141099276;8193.221643943816;8307.044689860744;8330.791730206793;8406.453580517247;8679.349048821363;14142.292885355691;14160.433582656784;14173;14190.645233869236;14203.147811131365;6046.09308603713;6075.756969721162;6109.938900611026;6196.442320191114;6199.721012554446;3328.883489077919;3381.03640462467;3415.64135765746;3418.4017796885446;3471.166919939247;2507.1726330310953;2511.3344963584664;2528.102523604094;2563.948721025569;2566.3712390464084;468.47764742312756;472.74235541629207;477.3508029080448;478.04868312058755;482.67419491842867;408.19178027505706;435.9934600980988;471.3942583779895;474.006955428377;502.2892606961182;6697.229818570927;7048.471364647672;7472.103347598214;7532.962335188398;7632.1154461144915;456.5959126173294;463.967969320489;508.71511953306265;522.1228336394818;547.4853637580661;3133.250485359391;3196.664350243191;3244.5944256967878;3249.5938007749032;3293.4730443128983;46433;47390.76304618455;47504.76247618809;47562;47649.5235047652;41325.1734965305;41429;41694.166116677494;41761.79119104385;42367.788161059;38451.615483845366;38520.80739596284;38825.223495530496;39860.601393985686;40019.79990100089;6346;6397.488200944006;6408.583442076437;6474.611523308617;6662.766803161866;29914.551281730357;29915.401691965602;30163.69836301609;30236.24409389783;30302.84848575743;35088.29823403569;37312;37753.62246377501;37820.43269350907;38080.42879356867;7842.333401660694;8161.428699990944;8198.549079800669;8329.458585191944;8338.541380223904;8985.415947963624;9091.818163636557;9205.769855753391;10100.797984040424;10252.282340236112;8800.33997450181;8943;9005.594748236475;9152.771180720536;9253.814923701622;9057.818843623223;9090.454572725657;9117.863232051657;9120.863187052068;9365.672201473188;8828.823423531621;8919.73240802777;9034.593443295198;9045.954770226106;9146.993830678486;8211.71259005932;8320.084790673141;8422.873656895274;8593.742187734379;8760.518171500375;7715.84262360628;7759.534427934342;7796.103448103314;7906.7627971160955;8079.515229086273 12:10:08 INFO - 2015-12-17 12:10:08,512 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:10:08 INFO - 2015-12-17 12:10:08,512 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:10:08 INFO - 2015-12-17 12:10:08,512 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,930 12:10:08 INFO - 2015-12-17 12:10:08,512 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:10:08 INFO - 2015-12-17 12:10:08,512 DEBUG : BROWSER_OUTPUT: __startTimestamp1450383008502__endTimestamp 12:10:08 INFO - 2015-12-17 12:10:08,512 DEBUG : BROWSER_OUTPUT: 12:10:08 INFO - 2015-12-17 12:10:08,514 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:10:08 INFO - 2015-12-17 12:10:08,514 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:10:08 INFO - 2015-12-17 12:10:08,514 DEBUG : BROWSER_OUTPUT: 12:10:08 INFO - 2015-12-17 12:10:08,514 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4676.23 Median:4795.81 stddev:499.22 (10.4%) stddev-sans-first:474.23 12:10:08 INFO - 2015-12-17 12:10:08,514 DEBUG : BROWSER_OUTPUT: Values: 2629.7 2721.1 2723.0 2732.4 2745.5 4569.8 4720.3 4748.1 4752.0 4774.9 4653.1 4662.3 4754.5 4763.5 4794.9 4313.0 4318.4 4364.3 4490.8 4507.5 4423.6 4466.8 4502.1 4509.4 4533.2 4214.3 4266.3 4318.4 4329.5 4355.2 4363.0 4369.9 4386.8 4393.3 4413.2 4339.5 4362.5 4365.7 4383.4 4397.6 4533.3 4626.7 4652.0 4666.8 4760.0 5021.9 5022.6 5030.1 5031.9 5082.9 5041.0 5052.6 5053.5 5112.1 5119.2 4521.7 4639.6 4642.0 4648.6 4680.6 5270.9 5274.7 5287.5 5316.1 5331.3 5050.1 5053.8 5060.3 5063.0 5127.3 4840.6 4962.5 4962.6 4978.5 5156.6 5051.6 5082.5 5086.7 5108.3 5125.1 5063.9 5075.3 5078.0 5082.9 5113.8 4012.2 4058.8 4101.8 4159.9 4293.4 3663.5 3664.2 3678.7 3697.8 3720.3 4331.2 4332.7 4337.6 4367.2 4370.7 4822.8 4936.0 4938.0 5035.0 5070.8 4307.1 4307.4 4313.0 4325.9 4347.0 4441.6 4441.7 4443.5 4445.5 4499.7 4602.2 4744.9 4750.5 4751.6 4810.2 5120.1 5121.3 5131.9 5147.8 5176.9 4843.4 4848.4 4850.6 4850.6 4887.1 4795.8 4882.0 5052.8 5058.4 5103.4 4994.9 5016.2 5123.4 5132.6 5168.5 4897.2 4900.8 4904.7 4907.6 4952.4 4660.4 4848.4 4910.0 4914.6 4965.7 4764.7 4782.3 4882.8 4901.9 4915.0 5051.0 5051.7 5052.8 5060.1 5063.2 4931.2 4949.0 4951.7 4954.4 4997.6 12:10:08 INFO - 2015-12-17 12:10:08,514 DEBUG : BROWSER_OUTPUT: 12:10:08 INFO - 2015-12-17 12:10:08,514 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42518.26 Median:18354.57 stddev:70733.56 (385.4%) stddev-sans-first:70861.80 12:10:08 INFO - 2015-12-17 12:10:08,514 DEBUG : BROWSER_OUTPUT: Values: 550.7 565.1 565.7 568.5 572.7 25353.0 25997.5 34885.7 35530.6 35545.0 40260.2 40657.8 40725.0 40869.0 40967.8 7059.7 7831.3 7949.8 8011.0 8015.2 7203.2 10007.1 10353.3 10357.2 10370.6 10035.9 10107.4 10115.4 10117.6 10118.1 7256.9 7457.7 10019.5 10110.5 10137.9 9746.0 9908.2 9912.6 9917.8 9923.5 37308.4 37708.8 37775.0 37886.0 37944.6 2591.5 2647.7 2714.3 2778.9 2866.9 26630.0 27106.3 27179.2 27548.4 27586.0 3234.6 3346.3 3353.4 3397.2 3415.4 214714.0 216422.0 216534.0 217000.0 217984.0 52411.7 53468.8 56003.0 56366.7 56439.4 60866.4 61220.4 61293.0 61324.4 61326.7 11330.0 11409.9 11456.9 11474.9 11513.5 8593.2 8608.6 8616.3 8621.3 8656.7 18552.5 18616.2 18624.4 19525.2 19539.2 7465.6 7658.2 7720.0 7789.8 7825.5 851.1 857.2 867.6 870.1 947.6 26373.3 26511.9 26726.5 26839.5 26855.3 860.8 884.8 920.1 934.7 951.7 13150.1 13369.1 13453.7 13526.2 13614.7 323889.0 328263.0 328378.0 328773.0 329656.0 46753.8 46988.5 47144.8 47171.8 47184.3 1174.7 1180.9 1190.9 1192.4 1192.9 24234.8 24945.6 25429.0 25449.6 25501.0 36893.8 37560.6 37563.4 37570.2 37596.4 252064.0 253699.0 253785.0 254307.0 254998.0 24532.0 24821.0 28195.4 28612.9 29440.6 32887.7 33089.3 46084.8 47297.5 47666.5 32754.3 33335.8 33469.3 33587.7 33635.8 30393.2 38350.6 38411.4 39725.0 40200.8 33362.8 33583.5 33731.7 33934.2 34089.3 29232.4 29910.6 30451.4 30508.8 30605.7 23513.9 23712.5 23763.4 23783.4 23863.8 12:10:08 INFO - 2015-12-17 12:10:08,514 DEBUG : BROWSER_OUTPUT: 12:10:08 INFO - 2015-12-17 12:10:08,514 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27341.48 Median:33298.32 stddev:79483.18 (238.7%) stddev-sans-first:79680.25 12:10:08 INFO - 2015-12-17 12:10:08,515 DEBUG : BROWSER_OUTPUT: Values: 315.4 318.1 322.2 323.3 325.6 12663.6 12966.2 15368.0 15959.8 16024.8 12192.7 14255.6 15412.5 16145.4 16185.7 4868.7 5029.5 6452.1 6667.4 6676.6 4118.6 4238.6 6434.3 6671.1 6703.3 6539.8 6547.8 6560.0 6582.7 6596.2 6455.0 6643.1 6644.1 6668.4 6683.1 6227.4 6378.4 6382.8 6391.7 6398.1 21289.6 21334.3 21367.4 21740.7 21848.8 1840.3 1840.7 1889.7 1900.5 1905.3 13113.7 13485.5 13522.2 13783.7 14073.4 1765.4 1803.9 1828.7 1857.6 1857.7 60383.0 60481.4 61567.7 64842.7 65138.3 15194.5 15258.6 15297.8 15310.3 15310.5 23082.8 23110.2 23363.2 23402.9 23418.8 7653.6 7913.9 7925.3 7980.1 7992.8 6575.4 6583.5 6617.7 6623.8 6670.2 7477.6 7515.2 7524.9 7556.8 7583.7 2497.6 2890.1 2898.5 2916.3 2931.6 834.8 837.7 906.8 949.1 970.7 13617.6 14993.3 15747.7 15853.1 16201.5 857.7 885.6 897.9 905.6 914.0 9177.4 9356.2 9380.8 9421.5 9473.2 472556.0 476737.0 494897.0 495488.0 496548.5 68520.3 68823.7 70163.6 71243.0 71794.6 959.9 959.9 1062.9 1092.9 1097.3 14614.7 14686.3 14878.5 14921.6 15125.4 30042.4 30329.1 32854.5 33742.1 35297.8 42241.8 42455.6 43171.8 44277.6 44328.6 8457.8 8788.9 8969.9 8974.7 9066.0 10199.7 10245.5 10306.9 10386.5 10402.7 12786.6 13876.9 13980.3 14073.4 14323.9 13743.5 13887.2 14025.0 14213.3 14275.3 14139.4 14208.1 14255.9 14548.0 14775.5 8926.5 8991.4 9017.2 9258.3 9267.7 10891.8 13223.3 13245.5 13372.8 13389.3 12:10:08 INFO - 2015-12-17 12:10:08,516 DEBUG : BROWSER_OUTPUT: 12:10:08 INFO - 2015-12-17 12:10:08,516 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4932.74 Median:5818.39 stddev:2592.62 (44.6%) stddev-sans-first:2584.66 12:10:08 INFO - 2015-12-17 12:10:08,516 DEBUG : BROWSER_OUTPUT: Values: 1193.6 1622.4 1690.1 1710.6 1726.9 6090.8 6862.6 7019.7 7039.4 7040.4 7049.5 7222.9 7226.0 7230.6 7239.1 2030.5 2074.3 2074.5 2077.7 2079.5 2084.9 2096.4 2098.3 2130.8 2136.4 2030.2 2043.4 2051.0 2051.8 2053.6 2037.6 2044.6 2056.2 2062.2 2068.4 2034.2 2041.2 2081.1 2082.4 2082.5 7044.4 7100.9 7109.5 7111.1 7151.1 4060.6 4134.8 4146.2 4150.2 4156.8 2629.2 2639.6 2671.5 2677.2 2693.7 864.8 867.5 885.2 906.7 910.2 9358.9 9365.6 9407.7 9408.8 9416.6 3690.8 3699.6 3753.3 3759.8 3766.9 8154.2 8154.3 8192.7 8192.9 8198.7 4074.7 4090.0 4097.1 4097.1 4099.1 3181.0 3253.5 3625.8 3784.8 3787.5 3339.0 3362.9 3382.0 3390.9 3396.8 1078.9 1091.3 1091.8 1097.2 1111.3 1152.6 1164.6 1187.3 1192.1 1209.6 6777.4 6820.6 6835.1 6892.6 6894.3 387.6 399.9 403.0 403.3 403.4 5194.6 5263.1 5277.4 5278.9 5280.3 8218.0 8301.7 8408.1 8626.8 8628.2 8430.5 8479.4 8525.0 8534.8 8548.5 6573.6 6612.1 6710.8 6735.2 6739.2 6751.7 6862.7 6866.0 6886.3 6895.2 7832.0 7845.7 7851.6 7877.2 7991.9 7950.7 8054.2 8132.8 8187.3 8257.7 5540.6 5625.5 6008.9 6075.7 6091.7 6001.6 6413.1 6536.5 6542.1 6543.1 6204.8 6339.6 6401.5 6516.1 6581.7 6260.5 6363.1 6395.4 6516.4 6584.7 6590.1 6631.6 6632.0 6633.3 6643.3 5751.6 5773.1 5797.2 5802.6 5803.9 5787.6 5788.0 5814.5 5817.1 5819.7 12:10:08 INFO - 2015-12-17 12:10:08,516 DEBUG : BROWSER_OUTPUT: 12:10:08 INFO - 2015-12-17 12:10:08,516 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4624.96 Median:5234.29 stddev:1348.31 (25.8%) stddev-sans-first:1312.32 12:10:08 INFO - 2015-12-17 12:10:08,516 DEBUG : BROWSER_OUTPUT: Values: 293.9 300.4 302.7 310.0 312.4 5260.4 5287.6 5313.9 5359.9 5385.1 5224.2 5227.5 5241.1 5243.5 5259.6 3886.3 4110.6 4130.9 4153.8 4159.6 3955.7 4084.9 4117.3 4119.0 4133.7 4063.2 4071.5 4073.6 4073.9 4084.8 3876.5 3943.4 4009.2 4079.2 4090.6 3641.7 3642.6 3643.0 3660.2 3665.1 5097.2 5098.6 5102.3 5118.3 5118.8 4744.8 4744.9 4751.0 4753.2 4753.5 5416.6 5534.5 5536.8 5540.7 5542.2 3947.8 3958.8 3959.2 3959.2 3962.5 5747.0 5849.8 5851.2 5854.8 5855.4 4082.4 4085.3 4085.6 4088.1 4089.7 3775.2 3912.9 4146.8 4149.9 4154.2 4182.5 4450.5 4589.6 4604.4 4712.0 5415.0 5542.0 5557.1 5566.4 5576.7 1447.1 1470.7 1470.8 1471.4 1471.6 997.2 1013.8 1019.0 1021.6 1029.6 4881.3 4889.1 4892.1 4895.8 4895.9 5745.7 5771.2 5772.2 5774.2 5779.8 4881.7 4890.7 4897.2 4898.5 4903.1 3043.8 3083.7 3118.4 3120.4 3127.0 5484.7 5495.1 5501.6 5503.3 5504.1 5950.8 5952.8 5956.2 5959.6 5960.9 5461.8 5479.1 5494.2 5494.8 5498.1 5618.7 5799.6 5800.8 5802.8 5808.0 5628.9 5651.5 5656.0 5666.7 5667.1 5477.2 5478.9 5485.5 5494.7 5501.8 4011.6 4065.1 4100.5 4101.2 4107.0 5750.9 5774.3 5777.7 5781.2 5787.4 5527.6 5533.6 5536.8 5538.5 5555.9 5563.3 5575.6 5580.2 5580.4 5584.7 5331.3 5434.3 5454.2 5457.6 5461.7 5428.6 5576.9 5599.4 5609.6 5616.5 5395.9 5486.7 5504.4 5516.9 5517.3 12:10:08 INFO - 2015-12-17 12:10:08,516 DEBUG : BROWSER_OUTPUT: 12:10:08 INFO - 2015-12-17 12:10:08,516 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11346.94 Median:6198.08 stddev:13225.81 (213.4%) stddev-sans-first:13238.47 12:10:08 INFO - 2015-12-17 12:10:08,517 DEBUG : BROWSER_OUTPUT: Values: 641.2 668.6 696.4 732.5 738.8 10924.5 11088.6 11102.7 11107.8 12109.1 12184.1 12291.4 12294.6 12310.8 12311.8 625.3 633.0 796.8 801.5 813.0 795.6 799.4 806.7 806.8 807.6 832.7 836.3 836.4 836.5 839.1 649.2 656.0 820.3 830.0 834.3 620.9 621.1 621.2 621.3 621.6 9230.1 9315.8 9350.6 9351.0 9359.6 10024.4 10371.7 10473.8 10602.5 10643.8 7695.5 7807.3 8704.7 8864.4 9001.8 2931.9 3040.1 3124.8 3126.0 3132.7 39250.6 39628.8 39638.6 39688.4 39717.8 8193.2 8307.0 8330.8 8406.5 8679.3 14142.3 14160.4 14173.0 14190.6 14203.1 6046.1 6075.8 6109.9 6196.4 6199.7 3328.9 3381.0 3415.6 3418.4 3471.2 2507.2 2511.3 2528.1 2563.9 2566.4 468.5 472.7 477.4 478.0 482.7 408.2 436.0 471.4 474.0 502.3 6697.2 7048.5 7472.1 7533.0 7632.1 456.6 464.0 508.7 522.1 547.5 3133.3 3196.7 3244.6 3249.6 3293.5 46433.0 47390.8 47504.8 47562.0 47649.5 41325.2 41429.0 41694.2 41761.8 42367.8 38451.6 38520.8 38825.2 39860.6 40019.8 6346.0 6397.5 6408.6 6474.6 6662.8 29914.6 29915.4 30163.7 30236.2 30302.8 35088.3 37312.0 37753.6 37820.4 38080.4 7842.3 8161.4 8198.5 8329.5 8338.5 8985.4 9091.8 9205.8 10100.8 10252.3 8800.3 8943.0 9005.6 9152.8 9253.8 9057.8 9090.5 9117.9 9120.9 9365.7 8828.8 8919.7 9034.6 9046.0 9147.0 8211.7 8320.1 8422.9 8593.7 8760.5 7715.8 7759.5 7796.1 7906.8 8079.5 12:10:08 INFO - 2015-12-17 12:10:08,517 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:10:08 INFO - 2015-12-17 12:10:08,518 DEBUG : BROWSER_OUTPUT: 12:10:09 INFO - 2015-12-17 12:10:09,399 INFO : Browser exited with error code: 0 12:10:09 INFO - 2015-12-17 12:10:09,417 INFO : Completed test dromaeo_css (00:18:37) 12:10:09 INFO - 2015-12-17 12:10:09,417 INFO : Starting test kraken 12:10:09 INFO - 2015-12-17 12:10:09,417 DEBUG : operating with platform_type : linux_ 12:10:09 INFO - 2015-12-17 12:10:09,417 INFO : Initialising browser for kraken test... 12:10:09 INFO - 2015-12-17 12:10:09,423 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdOfQur/profile http://localhost:35658/getInfo.html 12:10:13 INFO - 2015-12-17 12:10:13,250 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:10:13 INFO - 2015-12-17 12:10:13,251 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:10:13 INFO - 2015-12-17 12:10:13,251 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:10:13 INFO - 2015-12-17 12:10:13,251 DEBUG : BROWSER_OUTPUT: __metrics 12:10:13 INFO - 2015-12-17 12:10:13,408 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:10:13 INFO - 2015-12-17 12:10:13,464 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:10:14 INFO - 2015-12-17 12:10:14,541 INFO : Browser initialized. 12:10:14 INFO - 2015-12-17 12:10:14,542 INFO : Running cycle 1/1 for kraken test... 12:10:14 INFO - 2015-12-17 12:10:14,542 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdOfQur/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:10:26 INFO - 2015-12-17 12:10:26,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 149696512 12:10:26 INFO - 2015-12-17 12:10:26,506 DEBUG : BROWSER_OUTPUT: 12:10:29 INFO - 2015-12-17 12:10:29,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35658/tests/kraken/driver.html?testName=audio-beat-detection) 12:10:29 INFO - 2015-12-17 12:10:29,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 186933248 12:10:29 INFO - 2015-12-17 12:10:29,693 DEBUG : BROWSER_OUTPUT: 12:10:32 INFO - 2015-12-17 12:10:32,442 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35658/tests/kraken/driver.html?testName=audio-dft) 12:10:33 INFO - 2015-12-17 12:10:33,017 DEBUG : BROWSER_OUTPUT: RSS: Main: 175493120 12:10:33 INFO - 2015-12-17 12:10:33,017 DEBUG : BROWSER_OUTPUT: 12:10:36 INFO - 2015-12-17 12:10:36,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35658/tests/kraken/driver.html?testName=audio-fft) 12:10:36 INFO - 2015-12-17 12:10:36,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 159916032 12:10:36 INFO - 2015-12-17 12:10:36,590 DEBUG : BROWSER_OUTPUT: 12:10:38 INFO - 2015-12-17 12:10:38,609 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35658/tests/kraken/driver.html?testName=audio-oscillator) 12:10:39 INFO - 2015-12-17 12:10:39,182 DEBUG : BROWSER_OUTPUT: RSS: Main: 162824192 12:10:39 INFO - 2015-12-17 12:10:39,182 DEBUG : BROWSER_OUTPUT: 12:10:41 INFO - 2015-12-17 12:10:41,449 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35658/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:10:42 INFO - 2015-12-17 12:10:42,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 164048896 12:10:42 INFO - 2015-12-17 12:10:42,030 DEBUG : BROWSER_OUTPUT: 12:10:44 INFO - 2015-12-17 12:10:44,972 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35658/tests/kraken/driver.html?testName=imaging-darkroom) 12:10:45 INFO - 2015-12-17 12:10:45,545 DEBUG : BROWSER_OUTPUT: RSS: Main: 165351424 12:10:45 INFO - 2015-12-17 12:10:45,545 DEBUG : BROWSER_OUTPUT: 12:10:48 INFO - 2015-12-17 12:10:48,974 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35658/tests/kraken/driver.html?testName=imaging-desaturate) 12:10:49 INFO - 2015-12-17 12:10:49,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 165756928 12:10:49 INFO - 2015-12-17 12:10:49,556 DEBUG : BROWSER_OUTPUT: 12:10:52 INFO - 2015-12-17 12:10:52,418 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35658/tests/kraken/driver.html?testName=json-parse-financial) 12:10:53 INFO - 2015-12-17 12:10:53,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 164278272 12:10:53 INFO - 2015-12-17 12:10:53,004 DEBUG : BROWSER_OUTPUT: 12:10:54 INFO - 2015-12-17 12:10:54,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35658/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:10:55 INFO - 2015-12-17 12:10:55,339 DEBUG : BROWSER_OUTPUT: RSS: Main: 173801472 12:10:55 INFO - 2015-12-17 12:10:55,339 DEBUG : BROWSER_OUTPUT: 12:10:57 INFO - 2015-12-17 12:10:57,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:10:57 INFO - 2015-12-17 12:10:57,794 DEBUG : BROWSER_OUTPUT: RSS: Main: 173002752 12:10:57 INFO - 2015-12-17 12:10:57,794 DEBUG : BROWSER_OUTPUT: 12:10:59 INFO - 2015-12-17 12:10:59,917 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:11:00 INFO - 2015-12-17 12:11:00,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 182448128 12:11:00 INFO - 2015-12-17 12:11:00,498 DEBUG : BROWSER_OUTPUT: 12:11:03 INFO - 2015-12-17 12:11:03,054 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:11:03 INFO - 2015-12-17 12:11:03,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 189779968 12:11:03 INFO - 2015-12-17 12:11:03,636 DEBUG : BROWSER_OUTPUT: 12:11:06 INFO - 2015-12-17 12:11:06,242 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:11:06 INFO - 2015-12-17 12:11:06,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 186912768 12:11:06 INFO - 2015-12-17 12:11:06,823 DEBUG : BROWSER_OUTPUT: 12:11:08 INFO - 2015-12-17 12:11:08,592 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35658/tests/kraken/driver.html?testName=ai-astar) 12:11:08 INFO - 2015-12-17 12:11:08,838 DEBUG : BROWSER_OUTPUT: RSS: Main: 245370880 12:11:08 INFO - 2015-12-17 12:11:08,838 DEBUG : BROWSER_OUTPUT: 12:11:08 INFO - 2015-12-17 12:11:08,841 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:11:08 INFO - 2015-12-17 12:11:08,841 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:11:08 INFO - 2015-12-17 12:11:08,842 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:11:08 INFO - 2015-12-17 12:11:08,842 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:11:08 INFO - 2015-12-17 12:11:08,842 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;116;107;113;115;113;102;114;113;120 12:11:08 INFO - 2015-12-17 12:11:08,842 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;130;153;169;128;156;154;129;168;131 12:11:08 INFO - 2015-12-17 12:11:08,842 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;162;164;161;160;162;163;162;163 12:11:08 INFO - 2015-12-17 12:11:08,842 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;79;90;71;72;72;116;93;76 12:11:08 INFO - 2015-12-17 12:11:08,842 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;101;145;94;94;94;133;94;94;127 12:11:08 INFO - 2015-12-17 12:11:08,842 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;110;110;109;110;109;109 12:11:08 INFO - 2015-12-17 12:11:08,843 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;147;147;146;146;146;146;145;147 12:11:08 INFO - 2015-12-17 12:11:08,843 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;96;95;96;95;95;95;95 12:11:08 INFO - 2015-12-17 12:11:08,843 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;72;72;72;71;70;72;81;68;70 12:11:08 INFO - 2015-12-17 12:11:08,843 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;67;68;69;68;68;69;69 12:11:08 INFO - 2015-12-17 12:11:08,843 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;83;88;83;82;84;83;84;84 12:11:08 INFO - 2015-12-17 12:11:08,843 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;134;119;121;121;127;144;120;123;127 12:11:08 INFO - 2015-12-17 12:11:08,843 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;141;149;149;154;137;159;161;148;135 12:11:08 INFO - 2015-12-17 12:11:08,844 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;71;70;72;70;69;69;69;69;68 12:11:08 INFO - 2015-12-17 12:11:08,844 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:11:08 INFO - 2015-12-17 12:11:08,844 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:11:08 INFO - 2015-12-17 12:11:08,844 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,986 12:11:08 INFO - 2015-12-17 12:11:08,844 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:11:08 INFO - 2015-12-17 12:11:08,844 DEBUG : BROWSER_OUTPUT: __startTimestamp1450383068839__endTimestamp 12:11:08 INFO - 2015-12-17 12:11:08,844 DEBUG : BROWSER_OUTPUT: 12:11:08 INFO - 2015-12-17 12:11:08,848 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:11:08 INFO - 2015-12-17 12:11:08,848 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:11:08 INFO - 2015-12-17 12:11:08,848 DEBUG : BROWSER_OUTPUT: 12:11:08 INFO - 2015-12-17 12:11:08,848 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.60 Median:113.50 stddev:4.93 (4.3%) stddev-sans-first:5.22 12:11:08 INFO - 2015-12-17 12:11:08,848 DEBUG : BROWSER_OUTPUT: Values: 113.0 116.0 107.0 113.0 115.0 113.0 102.0 114.0 113.0 120.0 12:11:08 INFO - 2015-12-17 12:11:08,848 DEBUG : BROWSER_OUTPUT: 12:11:08 INFO - 2015-12-17 12:11:08,848 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.50 Median:155.00 stddev:16.39 (10.6%) stddev-sans-first:17.02 12:11:08 INFO - 2015-12-17 12:11:08,848 DEBUG : BROWSER_OUTPUT: Values: 157.0 130.0 153.0 169.0 128.0 156.0 154.0 129.0 168.0 131.0 12:11:08 INFO - 2015-12-17 12:11:08,848 DEBUG : BROWSER_OUTPUT: 12:11:08 INFO - 2015-12-17 12:11:08,848 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.32 (0.8%) stddev-sans-first:1.36 12:11:08 INFO - 2015-12-17 12:11:08,848 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 162.0 164.0 161.0 160.0 162.0 163.0 162.0 163.0 12:11:08 INFO - 2015-12-17 12:11:08,848 DEBUG : BROWSER_OUTPUT: 12:11:08 INFO - 2015-12-17 12:11:08,848 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.50 Median:75.00 stddev:14.41 (19.2%) stddev-sans-first:14.87 12:11:08 INFO - 2015-12-17 12:11:08,849 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 79.0 90.0 71.0 72.0 72.0 116.0 93.0 76.0 12:11:08 INFO - 2015-12-17 12:11:08,849 DEBUG : BROWSER_OUTPUT: 12:11:08 INFO - 2015-12-17 12:11:08,849 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.10 Median:94.00 stddev:19.85 (21.1%) stddev-sans-first:20.56 12:11:08 INFO - 2015-12-17 12:11:08,849 DEBUG : BROWSER_OUTPUT: Values: 95.0 101.0 145.0 94.0 94.0 94.0 133.0 94.0 94.0 127.0 12:11:08 INFO - 2015-12-17 12:11:08,849 DEBUG : BROWSER_OUTPUT: 12:11:08 INFO - 2015-12-17 12:11:08,849 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 12:11:08 INFO - 2015-12-17 12:11:08,849 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 110.0 110.0 109.0 110.0 109.0 109.0 12:11:08 INFO - 2015-12-17 12:11:08,849 DEBUG : BROWSER_OUTPUT: 12:11:08 INFO - 2015-12-17 12:11:08,849 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 12:11:08 INFO - 2015-12-17 12:11:08,849 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 145.0 147.0 12:11:08 INFO - 2015-12-17 12:11:08,849 DEBUG : BROWSER_OUTPUT: 12:11:08 INFO - 2015-12-17 12:11:08,849 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:11:08 INFO - 2015-12-17 12:11:08,849 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 12:11:08 INFO - 2015-12-17 12:11:08,849 DEBUG : BROWSER_OUTPUT: 12:11:08 INFO - 2015-12-17 12:11:08,849 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.20 Median:72.00 stddev:3.49 (4.8%) stddev-sans-first:3.64 12:11:08 INFO - 2015-12-17 12:11:08,850 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 72.0 72.0 71.0 70.0 72.0 81.0 68.0 70.0 12:11:08 INFO - 2015-12-17 12:11:08,850 DEBUG : BROWSER_OUTPUT: 12:11:08 INFO - 2015-12-17 12:11:08,850 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 12:11:08 INFO - 2015-12-17 12:11:08,850 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 67.0 68.0 69.0 68.0 68.0 69.0 69.0 12:11:08 INFO - 2015-12-17 12:11:08,850 DEBUG : BROWSER_OUTPUT: 12:11:08 INFO - 2015-12-17 12:11:08,850 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:1.70 (2.0%) stddev-sans-first:1.69 12:11:08 INFO - 2015-12-17 12:11:08,850 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 83.0 88.0 83.0 82.0 84.0 83.0 84.0 84.0 12:11:08 INFO - 2015-12-17 12:11:08,850 DEBUG : BROWSER_OUTPUT: 12:11:08 INFO - 2015-12-17 12:11:08,850 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:126.50 stddev:7.70 (6.1%) stddev-sans-first:8.17 12:11:08 INFO - 2015-12-17 12:11:08,850 DEBUG : BROWSER_OUTPUT: Values: 126.0 134.0 119.0 121.0 121.0 127.0 144.0 120.0 123.0 127.0 12:11:08 INFO - 2015-12-17 12:11:08,851 DEBUG : BROWSER_OUTPUT: 12:11:08 INFO - 2015-12-17 12:11:08,851 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.30 Median:149.00 stddev:8.98 (6.0%) stddev-sans-first:9.13 12:11:08 INFO - 2015-12-17 12:11:08,851 DEBUG : BROWSER_OUTPUT: Values: 140.0 141.0 149.0 149.0 154.0 137.0 159.0 161.0 148.0 135.0 12:11:08 INFO - 2015-12-17 12:11:08,851 DEBUG : BROWSER_OUTPUT: 12:11:08 INFO - 2015-12-17 12:11:08,851 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:1.23 (1.8%) stddev-sans-first:1.22 12:11:08 INFO - 2015-12-17 12:11:08,851 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 70.0 72.0 70.0 69.0 69.0 69.0 69.0 68.0 12:11:08 INFO - 2015-12-17 12:11:08,851 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:11:08 INFO - 2015-12-17 12:11:08,851 DEBUG : BROWSER_OUTPUT: 12:11:09 INFO - 2015-12-17 12:11:09,737 INFO : Browser exited with error code: 0 12:11:09 INFO - 2015-12-17 12:11:09,786 INFO : Completed test kraken (00:01:00) 12:11:09 INFO - 2015-12-17 12:11:09,787 INFO : Starting test v8_7 12:11:09 INFO - 2015-12-17 12:11:09,787 DEBUG : operating with platform_type : linux_ 12:11:09 INFO - 2015-12-17 12:11:09,787 INFO : Initialising browser for v8_7 test... 12:11:09 INFO - 2015-12-17 12:11:09,793 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM7C0xL/profile http://localhost:35658/getInfo.html 12:11:13 INFO - 2015-12-17 12:11:13,846 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:11:13 INFO - 2015-12-17 12:11:13,846 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:11:13 INFO - 2015-12-17 12:11:13,847 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:11:13 INFO - 2015-12-17 12:11:13,847 DEBUG : BROWSER_OUTPUT: __metrics 12:11:13 INFO - 2015-12-17 12:11:13,907 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:11:13 INFO - 2015-12-17 12:11:13,968 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:11:13 ERROR - 2015-12-17 12:11:13,983 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 12:11:14 INFO - 2015-12-17 12:11:14,911 INFO : Browser initialized. 12:11:14 INFO - 2015-12-17 12:11:14,912 INFO : Running cycle 1/1 for v8_7 test... 12:11:14 INFO - 2015-12-17 12:11:14,912 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM7C0xL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:11:26 INFO - 2015-12-17 12:11:26,889 DEBUG : BROWSER_OUTPUT: RSS: Main: 149540864 12:11:26 INFO - 2015-12-17 12:11:26,889 DEBUG : BROWSER_OUTPUT: 12:11:48 INFO - 2015-12-17 12:11:48,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35658/tests/v8_7/run.html (next: http://localhost:35658/tests/v8_7/run.html) 12:11:48 INFO - 2015-12-17 12:11:48,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 450310144 12:11:48 INFO - 2015-12-17 12:11:48,564 DEBUG : BROWSER_OUTPUT: 12:11:48 INFO - 2015-12-17 12:11:48,564 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:11:48 INFO - 2015-12-17 12:11:48,564 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:11:48 INFO - 2015-12-17 12:11:48,565 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:11:48 INFO - 2015-12-17 12:11:48,565 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:11:48 INFO - 2015-12-17 12:11:48,565 DEBUG : BROWSER_OUTPUT: |0;Richards;165.92002654720426 12:11:48 INFO - 2015-12-17 12:11:48,565 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.70102135561746 12:11:48 INFO - 2015-12-17 12:11:48,565 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.54648903691367 12:11:48 INFO - 2015-12-17 12:11:48,565 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5159.79381443299 12:11:48 INFO - 2015-12-17 12:11:48,565 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2036.6598778004072 12:11:48 INFO - 2015-12-17 12:11:48,566 DEBUG : BROWSER_OUTPUT: |5;Earley;786.1635220125786 12:11:48 INFO - 2015-12-17 12:11:48,566 DEBUG : BROWSER_OUTPUT: |6;Boyer;11929.411764705883 12:11:48 INFO - 2015-12-17 12:11:48,566 DEBUG : BROWSER_OUTPUT: |7;RegExp;27189.18918918919 12:11:48 INFO - 2015-12-17 12:11:48,566 DEBUG : BROWSER_OUTPUT: |8;Splay;618.8118811881188 12:11:48 INFO - 2015-12-17 12:11:48,566 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 12:11:48 INFO - 2015-12-17 12:11:48,566 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:11:48 INFO - 2015-12-17 12:11:48,567 DEBUG : BROWSER_OUTPUT: __startTimestamp1450383108563__endTimestamp 12:11:48 INFO - 2015-12-17 12:11:48,567 DEBUG : BROWSER_OUTPUT: 12:11:48 INFO - 2015-12-17 12:11:48,567 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:11:48 INFO - 2015-12-17 12:11:48,567 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:11:48 INFO - 2015-12-17 12:11:48,567 DEBUG : BROWSER_OUTPUT: 12:11:48 INFO - 2015-12-17 12:11:48,568 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.92 Median:165.92 stddev:0.00 (0.0%) 12:11:48 INFO - 2015-12-17 12:11:48,568 DEBUG : BROWSER_OUTPUT: Values: 165.9 12:11:48 INFO - 2015-12-17 12:11:48,568 DEBUG : BROWSER_OUTPUT: 12:11:48 INFO - 2015-12-17 12:11:48,568 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.70 Median:185.70 stddev:0.00 (0.0%) 12:11:48 INFO - 2015-12-17 12:11:48,569 DEBUG : BROWSER_OUTPUT: Values: 185.7 12:11:48 INFO - 2015-12-17 12:11:48,569 DEBUG : BROWSER_OUTPUT: 12:11:48 INFO - 2015-12-17 12:11:48,570 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.55 Median:277.55 stddev:0.00 (0.0%) 12:11:48 INFO - 2015-12-17 12:11:48,570 DEBUG : BROWSER_OUTPUT: Values: 277.5 12:11:48 INFO - 2015-12-17 12:11:48,570 DEBUG : BROWSER_OUTPUT: 12:11:48 INFO - 2015-12-17 12:11:48,570 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 12:11:48 INFO - 2015-12-17 12:11:48,570 DEBUG : BROWSER_OUTPUT: Values: 5159.8 12:11:48 INFO - 2015-12-17 12:11:48,570 DEBUG : BROWSER_OUTPUT: 12:11:48 INFO - 2015-12-17 12:11:48,570 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2036.66 Median:2036.66 stddev:0.00 (0.0%) 12:11:48 INFO - 2015-12-17 12:11:48,570 DEBUG : BROWSER_OUTPUT: Values: 2036.7 12:11:48 INFO - 2015-12-17 12:11:48,571 DEBUG : BROWSER_OUTPUT: 12:11:48 INFO - 2015-12-17 12:11:48,571 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:786.16 Median:786.16 stddev:0.00 (0.0%) 12:11:48 INFO - 2015-12-17 12:11:48,571 DEBUG : BROWSER_OUTPUT: Values: 786.2 12:11:48 INFO - 2015-12-17 12:11:48,571 DEBUG : BROWSER_OUTPUT: 12:11:48 INFO - 2015-12-17 12:11:48,571 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11929.41 Median:11929.41 stddev:0.00 (0.0%) 12:11:48 INFO - 2015-12-17 12:11:48,571 DEBUG : BROWSER_OUTPUT: Values: 11929.4 12:11:48 INFO - 2015-12-17 12:11:48,571 DEBUG : BROWSER_OUTPUT: 12:11:48 INFO - 2015-12-17 12:11:48,572 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27189.19 Median:27189.19 stddev:0.00 (0.0%) 12:11:48 INFO - 2015-12-17 12:11:48,572 DEBUG : BROWSER_OUTPUT: Values: 27189.2 12:11:48 INFO - 2015-12-17 12:11:48,572 DEBUG : BROWSER_OUTPUT: 12:11:48 INFO - 2015-12-17 12:11:48,572 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:618.81 Median:618.81 stddev:0.00 (0.0%) 12:11:48 INFO - 2015-12-17 12:11:48,572 DEBUG : BROWSER_OUTPUT: Values: 618.8 12:11:48 INFO - 2015-12-17 12:11:48,572 DEBUG : BROWSER_OUTPUT: 12:11:48 INFO - 2015-12-17 12:11:48,572 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 12:11:48 INFO - 2015-12-17 12:11:48,572 DEBUG : BROWSER_OUTPUT: Values: 4826.9 12:11:48 INFO - 2015-12-17 12:11:48,573 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:11:48 INFO - 2015-12-17 12:11:48,573 DEBUG : BROWSER_OUTPUT: 12:11:49 INFO - 2015-12-17 12:11:49,457 INFO : Browser exited with error code: 0 12:11:49 INFO - 2015-12-17 12:11:49,469 INFO : Completed test v8_7 (00:00:39) 12:11:49 INFO - 2015-12-17 12:11:49,590 INFO : Completed test suite (00:20:17) 12:11:49 INFO - 2015-12-17 12:11:49,591 DEBUG : Working with test: dromaeo_css 12:11:49 INFO - 2015-12-17 12:11:49,591 DEBUG : Generating results file: dromaeo_css 12:11:49 INFO - 2015-12-17 12:11:49,592 DEBUG : Working with test: kraken 12:11:49 INFO - 2015-12-17 12:11:49,592 DEBUG : Generating results file: kraken 12:11:49 INFO - 2015-12-17 12:11:49,592 INFO : javascript benchmark 12:11:49 INFO - 2015-12-17 12:11:49,592 DEBUG : Working with test: v8_7 12:11:49 INFO - 2015-12-17 12:11:49,592 DEBUG : Generating results file: v8_7 12:11:49 INFO - 2015-12-17 12:11:49,593 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:11:49 INFO - 2015-12-17 12:11:49,649 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 12:11:49 INFO - 2015-12-17 12:11:49,649 DEBUG : process_Request line: dromaeo_css 6310.66 graph.html#tests=[[72,132,35]] 12:11:49 INFO - 2015-12-17 12:11:49,649 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:11:49 INFO - 2015-12-17 12:11:49,684 DEBUG : process_Request line: kraken 1528.90 graph.html#tests=[[232,132,35]] 12:11:49 INFO - 2015-12-17 12:11:49,684 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:11:49 INFO - 2015-12-17 12:11:49,727 DEBUG : process_Request line: v8_7 19764.94 graph.html#tests=[[230,132,35]] 12:11:49 INFO - 2015-12-17 12:11:49,728 INFO : javascript benchmark 12:11:49 INFO - 2015-12-17 12:11:49,732 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2629.6975847777503, 2721.0748345562506, 2723.0061027724873, 2732.357895894466, 2745.4646343962922, 4569.794359253841, 4720.291956206566, 4748.050389922012, 4752.0, 4774.8806279842975, 4653.092646933849, 4662.277347011211, 4754.477007529169, 4763.4522029966565, 4794.856154315367, 4312.978435107836, 4318.395424640545, 4364.345348197764, 4490.820367185325, 4507.504174540798, 4423.601875831175, 4466.7766611669285, 4502.122086193193, 4509.413776209105, 4533.2066888294585, 4214.304639734455, 4266.274733295348, 4318.395424640553, 4329.480462344507, 4355.194289056535, 4362.956370436286, 4369.934450983238, 4386.780660966939, 4393.319035549495, 4413.227685155117, 4339.5443478434945, 4362.47650281965, 4365.694401391872, 4383.3863259143745, 4397.5602439756085, 4533.252013417782, 4626.699264547828, 4652.0, 4666.836660716858, 4759.952400475986, 5021.924671129936, 5022.573081288095, 5030.094582975063, 5031.899362012739, 5082.949170508285, 5041.0, 5052.646314757969, 5053.4946505349535, 5112.079825631385, 5119.155339368999, 4521.706089104197, 4639.582437580567, 4642.0, 4648.581627653527, 4680.625549955996, 5270.92093618596, 5274.657147285414, 5287.4976877196605, 5316.122839731478, 5331.306930099062, 5050.116229659795, 5053.84838454847, 5060.342155519759, 5063.0380227756605, 5127.307813445212, 4840.636952228527, 4962.478939711351, 4962.553370196628, 4978.5270399312, 5156.639035267495, 5051.595872330205, 5082.491750824962, 5086.720230387365, 5108.259302401131, 5125.051865404912, 5063.924041139386, 5075.289459475676, 5077.974610126926, 5082.923756143661, 5113.821016264487, 4012.1775036117524, 4058.817353219112, 4101.835926562963, 4159.9376009359885, 4293.355996600535, 3663.5420572428447, 3664.193877346979, 3678.7424880258127, 3697.8335974881193, 3720.311742327678, 4331.198728235287, 4332.740035597874, 4337.631301339358, 4367.213901497697, 4370.694051416434, 4822.758862056883, 4936.0, 4938.0, 5035.0, 5070.822521211814, 4307.073979094447, 4307.418498502662, 4312.956870431255, 4325.9134817303475, 4346.978265108654, 4441.578050085237, 4441.666874984389, 4443.511213766483, 4445.5109937907455, 4499.707519011319, 4602.194615942263, 4744.9051018978735, 4750.548697873696, 4751.619870410428, 4810.182269014206, 5120.078385890575, 5121.283020377075, 5131.923021154611, 5147.845564632918, 5176.896462070662, 4843.370361852936, 4848.369711937426, 4850.563449289581, 4850.636202284913, 4887.095887260868, 4795.808167673254, 4882.0, 5052.772625231947, 5058.367704036996, 5103.387593488805, 4994.925076123788, 5016.172331565397, 5123.38519377677, 5132.563732082815, 5168.508991645787, 4897.240927656219, 4900.828471003498, 4904.705717656952, 4907.55831975124, 4952.405711314521, 4660.4174478190225, 4848.393950756155, 4909.95090049095, 4914.631402644744, 4965.726885021359, 4764.714117152982, 4782.330473733749, 4882.755862206946, 4901.921577252999, 4915.0415668944215, 5051.015052064812, 5051.747412629427, 5052.8484145475695, 5060.063888180698, 5063.240513922941, 4931.211006238985, 4949.0, 4951.72765497901, 4954.355933728592, 4997.575206107522], "unit": "score", "name": "dojo.html", "value": 4644.6570159090425}, {"lowerIsBetter": false, "replicates": [550.6558400999373, 565.0958466453675, 565.67473702621, 568.5309619563861, 572.6506830833191, 25353.0, 25997.48005039898, 34885.65114348859, 35530.644693553055, 35545.0, 40260.16227646989, 40657.7967110164, 40725.0, 40869.0, 40967.79516102415, 7059.682314295844, 7831.3343365813835, 7949.761507154794, 8011.0, 8015.1984801519675, 7203.207647158808, 10007.09936105754, 10353.275270731052, 10357.223208259373, 10370.585176592966, 10035.899641003605, 10107.444090575053, 10115.443650599214, 10117.645882394118, 10118.13995810357, 7256.8548629027655, 7457.738979135758, 10019.499025048755, 10110.545025473797, 10137.949310253438, 9746.0, 9908.157806586449, 9912.55393507294, 9917.801643967152, 9923.503824808731, 37308.44037339442, 37708.811455942545, 37775.0, 37886.0, 37944.62055379466, 2591.4687489064695, 2647.7484638959268, 2714.3485563464824, 2778.9444211115865, 2866.942661146786, 26630.0, 27106.322341941413, 27179.184624461297, 27548.449031019467, 27586.0, 3234.5956755405573, 3346.297277571713, 3353.429916914106, 3397.2356219850335, 3415.3852306584804, 214714.0, 216422.0, 216534.0, 217000.0, 217984.0, 52411.73794131005, 53468.78171446805, 56003.0, 56366.71816640891, 56439.43560564424, 60866.391336086956, 61220.38779612147, 61293.0, 61324.38675613187, 61326.69336653377, 11330.0, 11409.942950285196, 11456.885431145749, 11474.942625286987, 11513.53945842157, 8593.183647553473, 8608.569571521399, 8616.310695144373, 8621.267192288726, 8656.69701560455, 18552.536186595444, 18616.162272697762, 18624.44126676202, 19525.218991240476, 19539.21843126259, 7465.6267186641535, 7658.2341765824085, 7720.0, 7789.844203115906, 7825.530468171928, 851.0935853316198, 857.2456238510072, 867.6139118092515, 870.1385628228135, 947.5877993073035, 26373.34066648311, 26511.867440662674, 26726.465470690477, 26839.463210736067, 26855.328616784347, 860.7934095817084, 884.8053428245776, 920.0661328751323, 934.6822080492665, 951.7002144324516, 13150.145240559334, 13369.131006484547, 13453.730925381633, 13526.18842869431, 13614.727705445835, 323889.0, 328263.0, 328378.0, 328773.0, 329656.0, 46753.76623116863, 46988.5301146991, 47144.7642761784, 47171.76414117976, 47184.29223561649, 1174.7298121432118, 1180.887815657511, 1190.898773604236, 1192.403798100967, 1192.9403529823473, 24234.757652423956, 24945.625815613144, 25429.0, 25449.61825572655, 25501.0, 36893.81553092218, 37560.624393755716, 37563.436548451245, 37570.24859502849, 37596.436053458674, 252064.0, 253699.0, 253785.0, 254307.0, 254998.0, 24532.0, 24821.0, 28195.43609127847, 28612.856935715186, 29440.55839162457, 32887.671123289416, 33089.33821323608, 46084.769576151906, 47297.52702473069, 47666.52333476621, 32754.34491310113, 33335.83332083324, 33469.33061338808, 33587.664123359435, 33635.831820840736, 30393.24016899595, 38350.61649383471, 38411.42382864315, 39725.00687482836, 40200.798996004836, 33362.833185833915, 33583.496247556795, 33731.662683373834, 33934.151646209044, 34089.318213636085, 29232.41535169327, 29910.551341730326, 30451.39097217999, 30508.847455763465, 30605.693943061175, 23513.88243058774, 23712.52574948457, 23763.405914851577, 23783.405414864766, 23863.76136238685], "unit": "score", "name": "ext.html", "value": 17011.553678695618}, {"lowerIsBetter": false, "replicates": [315.4322220003995, 318.077575032406, 322.21379833206976, 323.2677984365413, 325.589756906298, 12663.55677551286, 12966.222026678382, 15368.0, 15959.840401595995, 16024.759628605565, 12192.695182620439, 14255.643608909782, 15412.537623871274, 16145.354185832583, 16185.676286474263, 4868.707877527342, 5029.47190544993, 6452.064450654652, 6667.433268172211, 6676.599404035749, 4118.588141185873, 4238.618524332809, 6434.260060093103, 6671.066050752898, 6703.262641109474, 6539.77110801122, 6547.77082802102, 6559.983202603604, 6582.736690532373, 6596.175478065242, 6455.0, 6643.1363922690225, 6644.136262285871, 6668.433183179435, 6683.13119294491, 6227.3772622737815, 6378.425941665226, 6382.808515744488, 6391.744330226786, 6398.072279519443, 21289.574208515744, 21334.25330113454, 21367.35897923065, 21740.673889891663, 21848.781512184833, 1840.2730921286152, 1840.6686796376646, 1889.6787546117193, 1900.515368581017, 1905.3045638341905, 13113.737725245537, 13485.528006519724, 13522.188668679812, 13783.655408614764, 14073.437062517487, 1765.364468791247, 1803.8737288389818, 1828.7165489349172, 1857.6284743051444, 1857.7399164117035, 60383.0, 60481.39518604846, 61567.69216153935, 64842.675786621236, 65138.34861651323, 15194.468193613171, 15258.618534536725, 15297.770533441784, 15310.311036003184, 15310.540683779505, 23082.7691723084, 23110.19114331024, 23363.182288619817, 23402.882985585304, 23418.765812342, 7653.617319134021, 7913.920860791433, 7925.28672419485, 7980.082290536547, 7992.760217193493, 6575.44108750752, 6583.506237032242, 6617.735290588419, 6623.834404139839, 6670.199576050808, 7477.551346919094, 7515.173330933593, 7524.946507488956, 7556.773296801105, 7583.658735356922, 2497.5878979968466, 2890.118513853253, 2898.4927637663322, 2916.2855100500515, 2931.6335458067742, 834.7871292820292, 837.7109897085496, 906.8322360363222, 949.0699114867468, 970.7087873638021, 13617.591472255848, 14993.32530036151, 15747.68504629901, 15853.128077955593, 16201.513954581382, 857.6706105536393, 885.6191837509932, 897.9461232326081, 905.6196397512929, 913.9946059334811, 9177.449353038839, 9356.157945784777, 9380.812383752287, 9421.514039805315, 9473.242140628734, 472556.0, 476737.0, 494897.0, 495488.0, 496548.5172574114, 68520.3147968514, 68823.65588172027, 70163.64918175376, 71243.0, 71794.64102679453, 959.8656188133667, 959.8704174936295, 1062.8883967183335, 1092.907102896247, 1097.2757979733337, 14614.707705846036, 14686.339114739649, 14878.479253226518, 14921.552353429415, 15125.39498420095, 30042.399152017275, 30329.090127295334, 32854.507182391804, 33742.13191878718, 35297.823510882285, 42241.78879105585, 42455.575444245165, 43171.78414107909, 44277.55722442734, 44328.556714432445, 8457.83084338322, 8788.868166977372, 8969.865452018355, 8974.730758077269, 9066.0, 10199.7450063749, 10245.538950747085, 10306.896931030593, 10386.480675966322, 10402.687919362432, 12786.616401507597, 13876.930615346859, 13980.300984950509, 14073.366698498798, 14323.928380358031, 13743.450261989408, 13887.236202008582, 14025.0, 14213.289335533389, 14275.286235688382, 14139.36372863203, 14208.147511149364, 14255.928720356747, 14548.0, 14775.482858099915, 8926.464412135292, 8991.370604057653, 9017.188453038996, 9258.259339252978, 9267.67563135287, 10891.78216435651, 13223.3388330585, 13245.536406225736, 13372.799408008694, 13389.263590502616], "unit": "score", "name": "jquery.html", "value": 9144.999912294525}, {"lowerIsBetter": false, "replicates": [1193.5583833981427, 1622.4240394659896, 1690.062015581352, 1710.6236627941848, 1726.905020223888, 6090.756369745211, 6862.622555759432, 7019.68411421486, 7039.401650859671, 7040.401565866901, 7049.506534542584, 7222.927770722291, 7225.963870180642, 7230.60231687257, 7239.095113110861, 2030.4822270321047, 2074.274004098561, 2074.4917495213695, 2077.719507866434, 2079.511314841011, 2084.9478763030893, 2096.3710886733993, 2098.3495116513855, 2130.7656157822626, 2136.3590922723197, 2030.1574846438784, 2043.427840204745, 2051.046263487478, 2051.825594824442, 2053.5790163016545, 2037.623039737646, 2044.601302745965, 2056.23919149914, 2062.1648232465727, 2068.369147410039, 2034.206659402834, 2041.1529215375601, 2081.1363284237173, 2082.3648787119923, 2082.4689704125353, 7044.436445084381, 7100.928990710078, 7109.466789990772, 7111.146662400493, 7151.141862976424, 4060.634542891154, 4134.800907736752, 4146.170765846843, 4150.232207041707, 4156.8129434175535, 2629.184952664661, 2639.6304517367585, 2671.4523522677805, 2677.1700772760314, 2693.6902256240587, 864.7967727584013, 867.5141920524527, 885.2165833237567, 906.6554709210458, 910.2354022620964, 9358.859617105749, 9365.625374984993, 9407.717768466957, 9408.764780880532, 9416.62333506652, 3690.7785532868115, 3699.5560532736245, 3753.268112717994, 3759.793211373401, 3766.9434958475645, 8154.2253485918745, 8154.347652187811, 8192.713255036046, 8192.918070819334, 8198.713045043394, 4074.694397920168, 4089.9795501022304, 4097.09863829957, 4097.1191193893455, 4099.118689481776, 3180.9979856345176, 3253.528238405418, 3625.8005809680194, 3784.848606055727, 3787.450819631138, 3338.9666103338654, 3362.915927101793, 3382.0, 3390.8982730518123, 3396.8301584920655, 1078.8941335131553, 1091.307020042279, 1091.8143915534379, 1097.1716354152722, 1111.2610114273916, 1152.5735477873072, 1164.598213616301, 1187.26389638423, 1192.1357016163213, 1209.5887398284626, 6777.423918966943, 6820.624865632438, 6835.07726456922, 6892.586444813327, 6894.345037221557, 387.554312540575, 399.86204759357975, 402.9879103626896, 403.28819633347166, 403.3808104559546, 5194.584433245332, 5263.105272103751, 5277.445868183862, 5278.9208161877605, 5280.313559237275, 8218.0, 8301.709440169685, 8408.117147699526, 8626.792249085132, 8628.180322869317, 8430.494170349799, 8479.406441549156, 8524.957375213084, 8534.829303413897, 8548.529830859363, 6573.572717773234, 6612.140421745143, 6710.798676039727, 6735.191776986695, 6739.157605299338, 6751.662416879039, 6862.691178896862, 6866.038754574463, 6886.276940921131, 6895.172579290517, 7831.960840195762, 7845.725399610987, 7851.646675899712, 7877.212278772077, 7991.880121798062, 7950.7217247396065, 8054.23484768946, 8132.796680082809, 8187.3040791531, 8257.669693212445, 5540.584456165723, 5625.5218306442775, 6008.8798224036145, 6075.665838378932, 6091.664958427152, 6001.639901605918, 6413.1021656969, 6536.542442029012, 6542.084108224757, 6543.116679248431, 6204.844878878064, 6339.556231063966, 6401.487880969605, 6516.0551719999385, 6581.736730530725, 6260.467860231931, 6363.077353783768, 6395.360463953567, 6516.446102081376, 6584.670766461753, 6590.1103351046995, 6631.635260060743, 6632.0, 6633.336666333328, 6643.269240383651, 5751.626144300607, 5773.1051686988585, 5797.246357973437, 5802.622829516068, 5803.941960580509, 5787.594868359174, 5788.0, 5814.534837212928, 5817.127430885401, 5819.6508209507565], "unit": "score", "name": "mootools.html", "value": 3977.088022841003}, {"lowerIsBetter": false, "replicates": [293.9221106406802, 300.4126931848237, 302.74569361736144, 310.03887947363165, 312.3970736478598, 5260.395054568721, 5287.603429742765, 5313.8937221255555, 5359.919601205985, 5385.138377859544, 5224.242484839696, 5227.4511176326505, 5241.135212689902, 5243.475652434755, 5259.552938000265, 3886.3198940185353, 4110.568390319018, 4130.8554200602985, 4153.750774953497, 4159.646430053449, 3955.6835453163676, 4084.9387259191135, 4117.258893399187, 4119.011437255052, 4133.73130746502, 4063.1873625274916, 4071.5114186297687, 4073.572274911136, 4073.8574149904757, 4084.836606535735, 3876.457295978565, 3943.38877473992, 4009.2382447334912, 4079.224947260011, 4090.5704900985415, 3641.672249497558, 3642.581103173116, 3643.034595832107, 3660.249648821985, 3665.138692407282, 5097.209932460474, 5098.617603679739, 5102.285680004802, 5118.283440318359, 5118.846434606968, 4744.786484608201, 4744.928826067612, 4750.976245118787, 4753.215719406294, 4753.548412900769, 5416.593755468316, 5534.529564986981, 5536.778528858841, 5540.728301396408, 5542.168674698827, 3947.842086316544, 3958.8123562931005, 3959.208158368338, 3959.247742928834, 3962.4650672159178, 5747.0230060889335, 5849.795257165979, 5851.151583020481, 5854.795082172103, 5855.355910849803, 4082.3876418537457, 4085.325921222965, 4085.5914408558906, 4088.0801819590947, 4089.7137200395687, 3775.2072064866684, 3912.8630497932436, 4146.751194928314, 4149.854755083618, 4154.189932963043, 4182.477190351206, 4450.5104438511735, 4589.58693717567, 4604.355390245369, 4712.0, 5415.0, 5542.0, 5557.110862262019, 5566.443355664482, 5576.693281869536, 1447.0811034992855, 1470.6838029823639, 1470.8308544517304, 1471.3746657670447, 1471.624735692413, 997.1823105053786, 1013.7769690668041, 1018.9861088217123, 1021.6168936648756, 1029.552144817007, 4881.292212629149, 4889.095517329305, 4892.09496243189, 4895.779689913962, 4895.877603059952, 5745.741441635137, 5771.192033115367, 5772.249607551075, 5774.249347584787, 5779.797707080232, 4881.731504767272, 4890.706557606555, 4897.240927656219, 4898.485659005753, 4903.141950158708, 3043.7520616547554, 3083.691630836898, 3118.4075025745037, 3120.422721796475, 3126.9530957035663, 5484.670919744828, 5495.093309603951, 5501.587380946445, 5503.3120859892515, 5504.0643090674685, 5950.761969521171, 5952.761889524457, 5956.225690660186, 5959.582829201914, 5960.910586341209, 5461.808836690697, 5479.068558345091, 5494.230807686847, 5494.8076817312, 5498.092814685532, 5618.69097199658, 5799.623024503394, 5800.8259752207505, 5802.82591522255, 5807.9545681776, 5628.943710562842, 5651.491365777099, 5655.971720141373, 5666.660000399989, 5667.121596152603, 5477.178423236546, 5478.8904221914545, 5485.451454854483, 5494.725263736717, 5501.834944951658, 4011.597650732357, 4065.0650350418978, 4100.507939047214, 4101.159262351271, 4106.958930410778, 5750.913736294043, 5774.307083150049, 5777.653340799566, 5781.248437703071, 5787.36339002701, 5527.585431092603, 5533.557315414677, 5536.7785288588, 5538.529225015919, 5555.8611034722835, 5563.332400112013, 5575.581831362745, 5580.190872323572, 5580.441955804387, 5584.692841893735, 5331.333583302087, 5434.3207099112615, 5454.236406903116, 5457.645253058698, 5461.726913654381, 5428.6199966002005, 5576.86057848557, 5599.412061733459, 5609.635373700697, 5616.522595579421, 5395.892082158256, 5486.6982315973, 5504.4495550444635, 5516.862078448071, 5517.282753242052], "unit": "score", "name": "prototype.html", "value": 4195.798986492907}, {"lowerIsBetter": false, "replicates": [641.1724295855278, 668.5787953589238, 696.3593493985533, 732.4945787406689, 738.7931379213823, 10924.508397122128, 11088.611898583551, 11102.722431939206, 11107.833382499259, 12109.091818113633, 12184.086193535475, 12291.44688489018, 12294.63116106516, 12310.753784924296, 12311.815322770166, 625.2528228766625, 633.0409429713987, 796.8007998000514, 801.4870482890955, 813.0040700142338, 795.5624406576388, 799.4403917257914, 806.6853926968487, 806.7781360125983, 807.588130053671, 832.7210384521193, 836.3351135847016, 836.4019725895984, 836.4939211776879, 839.0728245288959, 649.1982401733854, 655.9672016399185, 820.2822530285999, 829.9626516806698, 834.3158609939852, 620.8758248350348, 621.1490258346095, 621.1645337021698, 621.3227581935666, 621.561798931752, 9230.123138301851, 9315.76710582234, 9350.57922393494, 9351.0, 9359.578818953163, 10024.398536087858, 10371.688849334532, 10473.79052418955, 10602.46987650622, 10643.787124257471, 7695.4997925134685, 7807.297343239079, 8704.651813927436, 8864.423812452234, 9001.819963600692, 2931.8973835915854, 3040.0727778027695, 3124.8125112493094, 3126.0, 3132.7180553750045, 39250.607493925265, 39628.80185599082, 39638.60361396378, 39688.4046739302, 39717.80141099276, 8193.221643943816, 8307.044689860744, 8330.791730206793, 8406.453580517247, 8679.349048821363, 14142.292885355691, 14160.433582656784, 14173.0, 14190.645233869236, 14203.147811131365, 6046.09308603713, 6075.756969721162, 6109.938900611026, 6196.442320191114, 6199.721012554446, 3328.883489077919, 3381.03640462467, 3415.64135765746, 3418.4017796885446, 3471.166919939247, 2507.1726330310953, 2511.3344963584664, 2528.102523604094, 2563.948721025569, 2566.3712390464084, 468.47764742312756, 472.74235541629207, 477.3508029080448, 478.04868312058755, 482.67419491842867, 408.19178027505706, 435.9934600980988, 471.3942583779895, 474.006955428377, 502.2892606961182, 6697.229818570927, 7048.471364647672, 7472.103347598214, 7532.962335188398, 7632.1154461144915, 456.5959126173294, 463.967969320489, 508.71511953306265, 522.1228336394818, 547.4853637580661, 3133.250485359391, 3196.664350243191, 3244.5944256967878, 3249.5938007749032, 3293.4730443128983, 46433.0, 47390.76304618455, 47504.76247618809, 47562.0, 47649.5235047652, 41325.1734965305, 41429.0, 41694.166116677494, 41761.79119104385, 42367.788161059, 38451.615483845366, 38520.80739596284, 38825.223495530496, 39860.601393985686, 40019.79990100089, 6346.0, 6397.488200944006, 6408.583442076437, 6474.611523308617, 6662.766803161866, 29914.551281730357, 29915.401691965602, 30163.69836301609, 30236.24409389783, 30302.84848575743, 35088.29823403569, 37312.0, 37753.62246377501, 37820.43269350907, 38080.42879356867, 7842.333401660694, 8161.428699990944, 8198.549079800669, 8329.458585191944, 8338.541380223904, 8985.415947963624, 9091.818163636557, 9205.769855753391, 10100.797984040424, 10252.282340236112, 8800.33997450181, 8943.0, 9005.594748236475, 9152.771180720536, 9253.814923701622, 9057.818843623223, 9090.454572725657, 9117.863232051657, 9120.863187052068, 9365.672201473188, 8828.823423531621, 8919.73240802777, 9034.593443295198, 9045.954770226106, 9146.993830678486, 8211.71259005932, 8320.084790673141, 8422.873656895274, 8593.742187734379, 8760.518171500375, 7715.84262360628, 7759.534427934342, 7796.103448103314, 7906.7627971160955, 8079.515229086273], "unit": "score", "name": "yui.html", "value": 5237.665187289915}], "name": "dromaeo_css", "value": 6310.658711573735}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 116.0, 107.0, 113.0, 115.0, 113.0, 102.0, 114.0, 113.0, 120.0], "unit": "score", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [157.0, 130.0, 153.0, 169.0, 128.0, 156.0, 154.0, 129.0, 168.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 147.5}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 164.0, 161.0, 160.0, 162.0, 163.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 79.0, 90.0, 71.0, 72.0, 72.0, 116.0, 93.0, 76.0], "unit": "score", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [95.0, 101.0, 145.0, 94.0, 94.0, 94.0, 133.0, 94.0, 94.0, 127.0], "unit": "score", "name": "audio-oscillator", "value": 107.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 72.0, 72.0, 71.0, 70.0, 72.0, 81.0, 68.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 72.2}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 67.0, 68.0, 69.0, 68.0, 68.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 83.0, 88.0, 83.0, 82.0, 84.0, 83.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [126.0, 134.0, 119.0, 121.0, 121.0, 127.0, 144.0, 120.0, 123.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.2}, {"lowerIsBetter": true, "replicates": [140.0, 141.0, 149.0, 149.0, 154.0, 137.0, 159.0, 161.0, 148.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.3}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 70.0, 72.0, 70.0, 69.0, 69.0, 69.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.8}], "name": "kraken", "value": 1528.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.92002654720426], "unit": "score", "name": "Richards", "value": 212.765154}, {"lowerIsBetter": false, "replicates": [185.70102135561746], "unit": "score", "name": "DeltaBlue", "value": 356.04543000000007}, {"lowerIsBetter": false, "replicates": [277.54648903691367], "unit": "score", "name": "Encrypt", "value": 959.0501430000003}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [2036.6598778004072], "unit": "score", "name": "RayTrace", "value": 363.33459900000014}, {"lowerIsBetter": false, "replicates": [786.1635220125786], "unit": "score", "name": "Earley", "value": 847.7409359999999}, {"lowerIsBetter": false, "replicates": [11929.411764705883], "unit": "score", "name": "Boyer", "value": 55.867214003944795}, {"lowerIsBetter": false, "replicates": [27189.18918918919], "unit": "score", "name": "RegExp", "value": 33.505412524850904}, {"lowerIsBetter": false, "replicates": [618.8118811881188], "unit": "score", "name": "Splay", "value": 131.68945600000004}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19764.93755410445}]} 12:11:49 INFO - RETURN: dromaeo_css: 6310.66 12:11:49 INFO - RETURN: kraken: 1528.90 12:11:49 INFO - RETURN: v8_7: 19764.94 12:11:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19764.94"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1528.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6310.66"}}} 12:11:49 INFO - Return code: 0 12:11:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:11:49 ERROR - # TBPL SUCCESS # 12:11:49 INFO - Running post-action listener: _resource_record_post_action 12:11:49 INFO - Running post-run listener: _resource_record_post_run 12:11:50 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 546607104; Read time: 12; Write time: 745260 12:11:50 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 226856960; Read time: 0; Write time: 428720 12:11:50 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 319750144; Read time: 12; Write time: 316540 12:11:50 INFO - Running post-run listener: _upload_blobber_files 12:11:50 INFO - Blob upload gear active. 12:11:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:11:50 INFO - Copying logs to upload dir... 12:11:50 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1274.821408 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-17 12:11:50.440188) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 12:11:50.444039) ========= 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=6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009977 build_url: 'https://queue.taskcluster.net/v1/task/FSVAy8vBQ4KfJBaKvsNm7w/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-17 12:11:50.498579) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 12:11:50.499095) ========= 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=6d5287d839824eebc594b0c9000001d1-1450379426.964016-1301399947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 12:11:50.549825) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 12:11:50.550127) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 12:11:50.550426) ========= ========= Total master_lag: 0.26 =========