builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1450454666.38 results: success (0) buildid: 20151218062800 builduid: 656c544a11f540fa9ee5a526fe39c7da revision: ce75ab3d79c631b2880e7894f9fd05d468aee1a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 08:04:26.381081) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 08:04:26.381489) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 08:04:26.381802) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006496 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 08:04:26.407366) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 08:04:26.407669) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 08:04:26.424775) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 08:04:26.425437) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004724 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 08:04:26.478843) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 08:04:26.479543) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 08:04:26.480380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 08:04:26.481067) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 08:04:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 215M=0s 2015-12-18 08:04:26 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102148 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 08:04:26.600905) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 08:04:26.601664) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022518 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 08:04:26.658153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 08:04:26.658686) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ce75ab3d79c631b2880e7894f9fd05d468aee1a5 --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 ce75ab3d79c631b2880e7894f9fd05d468aee1a5 --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=23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 08:04:26,902 truncating revision to first 12 chars 2015-12-18 08:04:26,902 Setting DEBUG logging. 2015-12-18 08:04:26,902 attempt 1/10 2015-12-18 08:04:26,902 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ce75ab3d79c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 08:04:27,162 unpacking tar archive at: fx-team-ce75ab3d79c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.555259 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 08:04:27.236920) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 08:04:27.237625) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 08:04:27.249088) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 08:04:27.249383) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 08:04:27.249810) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-18 08:04:27.250124) ========= /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=23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:04:27 INFO - MultiFileLogger online at 20151218 08:04:27 in /builds/slave/test 08:04:27 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 08:04:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:04:27 INFO - {'append_to_log': False, 08:04:27 INFO - 'base_work_dir': '/builds/slave/test', 08:04:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:04:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:04:27 INFO - 'branch': 'Fx-Team-Non-PGO', 08:04:27 INFO - 'buildbot_json_path': 'buildprops.json', 08:04:27 INFO - 'config_files': ('talos/linux_config.py',), 08:04:27 INFO - 'default_actions': ('clobber', 08:04:27 INFO - 'read-buildbot-config', 08:04:27 INFO - 'download-and-extract', 08:04:27 INFO - 'populate-webroot', 08:04:27 INFO - 'create-virtualenv', 08:04:27 INFO - 'install', 08:04:27 INFO - 'run-tests'), 08:04:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:04:27 INFO - 'download_minidump_stackwalk': True, 08:04:27 INFO - 'download_symbols': 'ondemand', 08:04:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:04:27 INFO - 'tooltool.py': '/tools/tooltool.py', 08:04:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:04:27 INFO - '/tools/misc-python/virtualenv.py')}, 08:04:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:04:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:04:27 INFO - 'installer_path': 'installer.exe', 08:04:27 INFO - 'log_level': 'info', 08:04:27 INFO - 'log_name': 'talos', 08:04:27 INFO - 'log_to_console': True, 08:04:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:04:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:04:27 INFO - 'opt_config_files': (), 08:04:27 INFO - 'pip_index': False, 08:04:27 INFO - 'sps_profile': False, 08:04:27 INFO - 'sps_profile_interval': 0, 08:04:27 INFO - 'suite': 'dromaeojs', 08:04:27 INFO - 'system_bits': '64', 08:04:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:04:27 INFO - 'title': 'talos-linux64-ix-030', 08:04:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:04:27 INFO - 'use_talos_json': True, 08:04:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:04:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:04:27 INFO - 'work_dir': 'build'} 08:04:27 INFO - ##### 08:04:27 INFO - ##### Running clobber step. 08:04:27 INFO - ##### 08:04:27 INFO - Running pre-action listener: _resource_record_pre_action 08:04:27 INFO - Running main action method: clobber 08:04:27 INFO - rmtree: /builds/slave/test/build 08:04:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:04:28 INFO - Running post-action listener: _resource_record_post_action 08:04:28 INFO - ##### 08:04:28 INFO - ##### Running read-buildbot-config step. 08:04:28 INFO - ##### 08:04:28 INFO - Running pre-action listener: _resource_record_pre_action 08:04:28 INFO - Running main action method: read_buildbot_config 08:04:28 INFO - Using buildbot properties: 08:04:28 INFO - { 08:04:28 INFO - "project": "", 08:04:28 INFO - "product": "firefox", 08:04:28 INFO - "script_repo_revision": "production", 08:04:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:04:28 INFO - "repository": "", 08:04:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:04:28 INFO - "buildid": "20151218062800", 08:04:28 INFO - "pgo_build": "False", 08:04:28 INFO - "basedir": "/builds/slave/test", 08:04:28 INFO - "buildnumber": 1030, 08:04:28 INFO - "slavename": "talos-linux64-ix-030", 08:04:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:04:28 INFO - "platform": "ubuntu64_hw", 08:04:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:04:28 INFO - "branch": "fx-team", 08:04:28 INFO - "repo_path": "integration/fx-team", 08:04:28 INFO - "revision": "ce75ab3d79c631b2880e7894f9fd05d468aee1a5", 08:04:28 INFO - "stage_platform": "linux64", 08:04:28 INFO - "builduid": "656c544a11f540fa9ee5a526fe39c7da", 08:04:28 INFO - "slavebuilddir": "test" 08:04:28 INFO - } 08:04:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:04:28 INFO - Running post-action listener: _resource_record_post_action 08:04:28 INFO - ##### 08:04:28 INFO - ##### Running download-and-extract step. 08:04:28 INFO - ##### 08:04:28 INFO - Running pre-action listener: _resource_record_pre_action 08:04:28 INFO - Running main action method: download_and_extract 08:04:28 INFO - mkdir: /builds/slave/test/build/tests 08:04:28 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')]} 08:04:28 INFO - https://queue.taskcluster.net/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:04:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/test_packages.json 08:04:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/test_packages.json 08:04:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:04:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:04:29 INFO - Downloaded 1302 bytes. 08:04:29 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:04:29 INFO - Using the following test package requirements: 08:04:29 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:04:29 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:04:29 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:29 INFO - u'jsshell-linux-x86_64.zip'], 08:04:29 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:04:29 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:04:29 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:04:29 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:04:29 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:04:29 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:04:29 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:04:29 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:29 INFO - https://queue.taskcluster.net/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:04:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCH_plYIRxik3spqFvPrqw/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 08:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCH_plYIRxik3spqFvPrqw/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 08:04:30 INFO - Downloaded 21872118 bytes. 08:04:30 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 08:04:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:30 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 08:04:31 INFO - Return code: 0 08:04:31 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 08:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:31 INFO - https://queue.taskcluster.net/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:04:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCH_plYIRxik3spqFvPrqw/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 08:04:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCH_plYIRxik3spqFvPrqw/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 08:04:33 INFO - Downloaded 21872118 bytes. 08:04:33 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 08:04:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:33 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 08:04:34 INFO - Return code: 0 08:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:34 INFO - https://queue.taskcluster.net/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:04:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:04:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:04:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCH_plYIRxik3spqFvPrqw/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 08:04:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCH_plYIRxik3spqFvPrqw/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 08:04:35 INFO - Downloaded 11132039 bytes. 08:04:35 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 08:04:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:04:35 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 08:04:35 INFO - Return code: 0 08:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:35 INFO - https://queue.taskcluster.net/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:04:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:04:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:04:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCH_plYIRxik3spqFvPrqw/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 08:04:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCH_plYIRxik3spqFvPrqw/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 08:04:37 INFO - Downloaded 53017972 bytes. 08:04:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:04:37 INFO - mkdir: /builds/slave/test/properties 08:04:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:04:37 INFO - Writing to file /builds/slave/test/properties/build_url 08:04:37 INFO - Contents: 08:04:37 INFO - build_url:https://queue.taskcluster.net/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:04:37 INFO - Running post-action listener: _resource_record_post_action 08:04:37 INFO - Running post-action listener: set_extra_try_arguments 08:04:37 INFO - ##### 08:04:37 INFO - ##### Running populate-webroot step. 08:04:37 INFO - ##### 08:04:37 INFO - Running pre-action listener: _resource_record_pre_action 08:04:37 INFO - Running main action method: populate_webroot 08:04:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:04:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:04:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:04:37 INFO - '--tppagecycles', 08:04:37 INFO - '7'], 08:04:37 INFO - 'tests': ['tsvgm']}}, 08:04:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:04:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:04:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:04:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:04:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:04:37 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:04:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:04:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:37 INFO - 'talos_options': ['--e10s'], 08:04:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:04:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:37 INFO - 'tests': ['damp', 'tps']}, 08:04:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:37 INFO - 'talos_options': ['--e10s'], 08:04:37 INFO - 'tests': ['damp', 'tps']}, 08:04:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:04:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:04:37 INFO - 'other': {'tests': ['a11yr', 08:04:37 INFO - 'ts_paint', 08:04:37 INFO - 'tpaint', 08:04:37 INFO - 'sessionrestore', 08:04:37 INFO - 'sessionrestore_no_auto_restore']}, 08:04:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:04:37 INFO - 'tests': ['a11yr', 08:04:37 INFO - 'ts_paint', 08:04:37 INFO - 'tpaint', 08:04:37 INFO - 'sessionrestore', 08:04:37 INFO - 'sessionrestore_no_auto_restore']}, 08:04:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:04:37 INFO - 'tests': ['a11yr', 08:04:37 INFO - 'ts_paint', 08:04:37 INFO - 'tpaint', 08:04:37 INFO - 'sessionrestore', 08:04:37 INFO - 'sessionrestore_no_auto_restore']}, 08:04:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:04:37 INFO - 'tests': ['a11yr', 08:04:37 INFO - 'ts_paint', 08:04:37 INFO - 'tpaint', 08:04:37 INFO - 'sessionrestore', 08:04:37 INFO - 'sessionrestore_no_auto_restore']}, 08:04:37 INFO - 'other_l64': {'tests': ['a11yr', 08:04:37 INFO - 'ts_paint', 08:04:37 INFO - 'tpaint', 08:04:37 INFO - 'sessionrestore', 08:04:37 INFO - 'sessionrestore_no_auto_restore']}, 08:04:37 INFO - 'other_nol64': {'tests': ['a11yr', 08:04:37 INFO - 'ts_paint', 08:04:37 INFO - 'tpaint', 08:04:37 INFO - 'sessionrestore', 08:04:37 INFO - 'sessionrestore_no_auto_restore']}, 08:04:37 INFO - 'svgr': {'tests': ['tsvgx', 08:04:37 INFO - 'tsvgr_opacity', 08:04:37 INFO - 'tart', 08:04:37 INFO - 'tscrollx', 08:04:37 INFO - 'cart']}, 08:04:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:04:37 INFO - 'tests': ['tsvgx', 08:04:37 INFO - 'tsvgr_opacity', 08:04:37 INFO - 'tart', 08:04:37 INFO - 'tscrollx', 08:04:37 INFO - 'cart']}, 08:04:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:37 INFO - 'tests': ['tp5o']}, 08:04:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:37 INFO - 'talos_options': ['--e10s'], 08:04:37 INFO - 'tests': ['tp5o']}, 08:04:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:37 INFO - 'talos_options': ['--xperf_path', 08:04:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:04:37 INFO - 'tests': ['tp5n']}, 08:04:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:37 INFO - 'talos_options': ['--e10s', 08:04:37 INFO - '--xperf_path', 08:04:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:04:37 INFO - 'tests': ['tp5n']}}, 08:04:37 INFO - 'talos.zip': {'path': '', 08:04:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:04:37 INFO - Running post-action listener: _resource_record_post_action 08:04:37 INFO - ##### 08:04:37 INFO - ##### Running create-virtualenv step. 08:04:37 INFO - ##### 08:04:37 INFO - Running pre-action listener: _resource_record_pre_action 08:04:37 INFO - Running main action method: create_virtualenv 08:04:37 INFO - Creating virtualenv /builds/slave/test/build/venv 08:04:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:04:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:04:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:04:37 INFO - Using real prefix '/usr' 08:04:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:04:38 INFO - Installing distribute.............................................................................................................................................................................................done. 08:04:40 INFO - Installing pip.................done. 08:04:40 INFO - Return code: 0 08:04:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f521f101f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac00b0>, '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 0x1ac0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410', '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 08:04:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:04:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:04:40 INFO - Using env: {'DISPLAY': ':0', 08:04:40 INFO - 'HOME': '/home/cltbld', 08:04:40 INFO - 'LANG': 'en_US.UTF-8', 08:04:40 INFO - 'LANGUAGE': 'en_US:en', 08:04:40 INFO - 'LOGNAME': 'cltbld', 08:04:40 INFO - 'MAIL': '/var/mail/cltbld', 08:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:40 INFO - 'MOZ_NO_REMOTE': '1', 08:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:40 INFO - 'NO_EM_RESTART': '1', 08:04:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:40 INFO - 'PWD': '/builds/slave/test', 08:04:40 INFO - 'SHELL': '/bin/bash', 08:04:40 INFO - 'SHLVL': '1', 08:04:40 INFO - 'TERM': 'linux', 08:04:40 INFO - 'TMOUT': '86400', 08:04:40 INFO - 'USER': 'cltbld', 08:04:40 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410', 08:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:40 INFO - '_': '/tools/buildbot/bin/python'} 08:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:04:40 INFO - Cleaning up... 08:04:40 INFO - Return code: 0 08:04:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f521f101f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac00b0>, '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 0x1ac0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410', '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 08:04:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:04:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:04:40 INFO - Using env: {'DISPLAY': ':0', 08:04:40 INFO - 'HOME': '/home/cltbld', 08:04:40 INFO - 'LANG': 'en_US.UTF-8', 08:04:40 INFO - 'LANGUAGE': 'en_US:en', 08:04:40 INFO - 'LOGNAME': 'cltbld', 08:04:40 INFO - 'MAIL': '/var/mail/cltbld', 08:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:40 INFO - 'MOZ_NO_REMOTE': '1', 08:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:40 INFO - 'NO_EM_RESTART': '1', 08:04:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:40 INFO - 'PWD': '/builds/slave/test', 08:04:40 INFO - 'SHELL': '/bin/bash', 08:04:40 INFO - 'SHLVL': '1', 08:04:40 INFO - 'TERM': 'linux', 08:04:40 INFO - 'TMOUT': '86400', 08:04:40 INFO - 'USER': 'cltbld', 08:04:40 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410', 08:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:40 INFO - '_': '/tools/buildbot/bin/python'} 08:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:40 INFO - Downloading/unpacking psutil>=0.7.1 08:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:42 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:04:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:04:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:04:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:42 INFO - Installing collected packages: psutil 08:04:42 INFO - Running setup.py install for psutil 08:04:42 INFO - building 'psutil._psutil_linux' extension 08:04:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:04:42 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 08:04:42 INFO - building 'psutil._psutil_posix' extension 08:04:42 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 08:04:42 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 08:04:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:42 INFO - Successfully installed psutil 08:04:42 INFO - Cleaning up... 08:04:42 INFO - Return code: 0 08:04:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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')]} 08:04:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:42 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 0x7f521f101f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac00b0>, '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 0x1ac0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410', '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 08:04:42 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 08:04:42 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 08:04:42 INFO - Using env: {'DISPLAY': ':0', 08:04:42 INFO - 'HOME': '/home/cltbld', 08:04:42 INFO - 'LANG': 'en_US.UTF-8', 08:04:42 INFO - 'LANGUAGE': 'en_US:en', 08:04:42 INFO - 'LOGNAME': 'cltbld', 08:04:42 INFO - 'MAIL': '/var/mail/cltbld', 08:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:42 INFO - 'MOZ_NO_REMOTE': '1', 08:04:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:42 INFO - 'NO_EM_RESTART': '1', 08:04:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:42 INFO - 'PWD': '/builds/slave/test', 08:04:42 INFO - 'SHELL': '/bin/bash', 08:04:42 INFO - 'SHLVL': '1', 08:04:42 INFO - 'TERM': 'linux', 08:04:42 INFO - 'TMOUT': '86400', 08:04:42 INFO - 'USER': 'cltbld', 08:04:42 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410', 08:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:42 INFO - '_': '/tools/buildbot/bin/python'} 08:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:04:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:04:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:04:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:04:44 INFO - Installing collected packages: mozsystemmonitor 08:04:44 INFO - Running setup.py install for mozsystemmonitor 08:04:44 INFO - Successfully installed mozsystemmonitor 08:04:44 INFO - Cleaning up... 08:04:44 INFO - Return code: 0 08:04:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f521f101f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac00b0>, '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 0x1ac0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410', '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 08:04:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:04:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:04:44 INFO - Using env: {'DISPLAY': ':0', 08:04:44 INFO - 'HOME': '/home/cltbld', 08:04:44 INFO - 'LANG': 'en_US.UTF-8', 08:04:44 INFO - 'LANGUAGE': 'en_US:en', 08:04:44 INFO - 'LOGNAME': 'cltbld', 08:04:44 INFO - 'MAIL': '/var/mail/cltbld', 08:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:44 INFO - 'MOZ_NO_REMOTE': '1', 08:04:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:44 INFO - 'NO_EM_RESTART': '1', 08:04:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:44 INFO - 'PWD': '/builds/slave/test', 08:04:44 INFO - 'SHELL': '/bin/bash', 08:04:44 INFO - 'SHLVL': '1', 08:04:44 INFO - 'TERM': 'linux', 08:04:44 INFO - 'TMOUT': '86400', 08:04:44 INFO - 'USER': 'cltbld', 08:04:44 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410', 08:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:44 INFO - '_': '/tools/buildbot/bin/python'} 08:04:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:45 INFO - Downloading/unpacking blobuploader==1.2.4 08:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:46 INFO - Downloading blobuploader-1.2.4.tar.gz 08:04:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:04:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:04:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:04:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:04:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:47 INFO - Downloading docopt-0.6.1.tar.gz 08:04:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:04:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:04:47 INFO - Installing collected packages: blobuploader, requests, docopt 08:04:47 INFO - Running setup.py install for blobuploader 08:04:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:04:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:04:47 INFO - Running setup.py install for requests 08:04:48 INFO - Running setup.py install for docopt 08:04:48 INFO - Successfully installed blobuploader requests docopt 08:04:48 INFO - Cleaning up... 08:04:48 INFO - Return code: 0 08:04:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f521f101f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac00b0>, '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 0x1ac0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410', '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 08:04:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:04:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:04:48 INFO - Using env: {'DISPLAY': ':0', 08:04:48 INFO - 'HOME': '/home/cltbld', 08:04:48 INFO - 'LANG': 'en_US.UTF-8', 08:04:48 INFO - 'LANGUAGE': 'en_US:en', 08:04:48 INFO - 'LOGNAME': 'cltbld', 08:04:48 INFO - 'MAIL': '/var/mail/cltbld', 08:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:48 INFO - 'MOZ_NO_REMOTE': '1', 08:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:48 INFO - 'NO_EM_RESTART': '1', 08:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:48 INFO - 'PWD': '/builds/slave/test', 08:04:48 INFO - 'SHELL': '/bin/bash', 08:04:48 INFO - 'SHLVL': '1', 08:04:48 INFO - 'TERM': 'linux', 08:04:48 INFO - 'TMOUT': '86400', 08:04:48 INFO - 'USER': 'cltbld', 08:04:48 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410', 08:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:48 INFO - '_': '/tools/buildbot/bin/python'} 08:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:04:48 INFO - Running setup.py (path:/tmp/pip-xLlZbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:04:48 INFO - Running setup.py (path:/tmp/pip-LtnmEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:04:48 INFO - Running setup.py (path:/tmp/pip-0B10YD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:04:48 INFO - Running setup.py (path:/tmp/pip-_PyqHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:04:48 INFO - Running setup.py (path:/tmp/pip-Y1Zf4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:04:48 INFO - Running setup.py (path:/tmp/pip-vVbW29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:04:48 INFO - Running setup.py (path:/tmp/pip-V0RI_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:04:48 INFO - Running setup.py (path:/tmp/pip-G1fDVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:04:48 INFO - Running setup.py (path:/tmp/pip-ciOqNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:04:49 INFO - Running setup.py (path:/tmp/pip-jJApSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:04:49 INFO - Running setup.py (path:/tmp/pip-ahzjmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:04:49 INFO - Running setup.py (path:/tmp/pip-6lLoAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:04:49 INFO - Running setup.py (path:/tmp/pip-obFVn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:04:49 INFO - Running setup.py (path:/tmp/pip-Cp9XpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:49 INFO - Running setup.py (path:/tmp/pip-mDqCS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:04:49 INFO - Running setup.py (path:/tmp/pip-A7FrWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:04:49 INFO - Running setup.py (path:/tmp/pip-pYUMQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:04:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:04:49 INFO - Running setup.py install for manifestparser 08:04:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:04:49 INFO - Running setup.py install for mozcrash 08:04:49 INFO - Running setup.py install for mozdebug 08:04:49 INFO - Running setup.py install for mozdevice 08:04:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:04:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:04:50 INFO - Running setup.py install for mozfile 08:04:50 INFO - Running setup.py install for mozhttpd 08:04:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:04:50 INFO - Running setup.py install for mozinfo 08:04:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:04:50 INFO - Running setup.py install for mozInstall 08:04:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:04:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:04:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:04:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:04:50 INFO - Running setup.py install for mozleak 08:04:50 INFO - Running setup.py install for mozlog 08:04:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:04:50 INFO - Running setup.py install for moznetwork 08:04:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:04:50 INFO - Running setup.py install for mozprocess 08:04:50 INFO - Running setup.py install for mozprofile 08:04:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:04:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:04:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:04:50 INFO - Running setup.py install for mozrunner 08:04:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:04:51 INFO - Running setup.py install for mozscreenshot 08:04:51 INFO - Running setup.py install for moztest 08:04:51 INFO - Running setup.py install for mozversion 08:04:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:04:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:04:51 INFO - Cleaning up... 08:04:51 INFO - Return code: 0 08:04:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f521f101f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac00b0>, '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 0x1ac0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410', '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 08:04:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:04:51 INFO - Using env: {'DISPLAY': ':0', 08:04:51 INFO - 'HOME': '/home/cltbld', 08:04:51 INFO - 'LANG': 'en_US.UTF-8', 08:04:51 INFO - 'LANGUAGE': 'en_US:en', 08:04:51 INFO - 'LOGNAME': 'cltbld', 08:04:51 INFO - 'MAIL': '/var/mail/cltbld', 08:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:51 INFO - 'MOZ_NO_REMOTE': '1', 08:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:51 INFO - 'NO_EM_RESTART': '1', 08:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:51 INFO - 'PWD': '/builds/slave/test', 08:04:51 INFO - 'SHELL': '/bin/bash', 08:04:51 INFO - 'SHLVL': '1', 08:04:51 INFO - 'TERM': 'linux', 08:04:51 INFO - 'TMOUT': '86400', 08:04:51 INFO - 'USER': 'cltbld', 08:04:51 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410', 08:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:51 INFO - '_': '/tools/buildbot/bin/python'} 08:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:04:51 INFO - Running setup.py (path:/tmp/pip-a749nV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:04:51 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)) 08:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:04:51 INFO - Running setup.py (path:/tmp/pip-GeiLKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:04:51 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)) 08:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:04:51 INFO - Running setup.py (path:/tmp/pip-uJYRoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:04:51 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)) 08:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:04:51 INFO - Running setup.py (path:/tmp/pip-NfKVv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:04:51 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)) 08:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:04:51 INFO - Running setup.py (path:/tmp/pip-6oNX2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:04:51 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)) 08:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:04:51 INFO - Running setup.py (path:/tmp/pip-aB4pE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:04:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:04:52 INFO - Running setup.py (path:/tmp/pip-LQkSjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:04:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:04:52 INFO - Running setup.py (path:/tmp/pip-ANuKyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:04:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:04:52 INFO - Running setup.py (path:/tmp/pip-XWqUm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:04:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:04:52 INFO - Running setup.py (path:/tmp/pip-kTK3WQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:04:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:04:52 INFO - Running setup.py (path:/tmp/pip-DuxaNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:04:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:04:52 INFO - Running setup.py (path:/tmp/pip-pp9Evj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:04:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:04:52 INFO - Running setup.py (path:/tmp/pip-o41Isk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:04:52 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)) 08:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:04:52 INFO - Running setup.py (path:/tmp/pip-Lvb7RS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:04:52 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)) 08:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:52 INFO - Running setup.py (path:/tmp/pip-TslIqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:52 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)) 08:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:04:52 INFO - Running setup.py (path:/tmp/pip-bp0Q7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:04:52 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)) 08:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:04:52 INFO - Running setup.py (path:/tmp/pip-C0Ljj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:04:52 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)) 08:04:52 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)) 08:04:52 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)) 08:04:52 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)) 08:04:52 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)) 08:04:52 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)) 08:04:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:04:52 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 08:04:52 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 08:04:52 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 08:04:52 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 08:04:52 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 08:04:52 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 08:04:54 INFO - Downloading blessings-1.5.1.tar.gz 08:04:54 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 08:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:04:54 INFO - Installing collected packages: blessings 08:04:54 INFO - Running setup.py install for blessings 08:04:54 INFO - Successfully installed blessings 08:04:54 INFO - Cleaning up... 08:04:54 INFO - Return code: 0 08:04:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:04:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:04:54 INFO - Reading from file tmpfile_stdout 08:04:54 INFO - Current package versions: 08:04:54 INFO - argparse == 1.2.1 08:04:54 INFO - blessings == 1.5.1 08:04:54 INFO - blobuploader == 1.2.4 08:04:54 INFO - docopt == 0.6.1 08:04:54 INFO - manifestparser == 1.1 08:04:54 INFO - mozInstall == 1.12 08:04:54 INFO - mozcrash == 0.16 08:04:54 INFO - mozdebug == 0.1 08:04:54 INFO - mozdevice == 0.47 08:04:54 INFO - mozfile == 1.2 08:04:54 INFO - mozhttpd == 0.7 08:04:54 INFO - mozinfo == 0.9 08:04:54 INFO - mozleak == 0.1 08:04:54 INFO - mozlog == 3.1 08:04:54 INFO - moznetwork == 0.27 08:04:54 INFO - mozprocess == 0.22 08:04:54 INFO - mozprofile == 0.27 08:04:54 INFO - mozrunner == 6.11 08:04:54 INFO - mozscreenshot == 0.1 08:04:54 INFO - mozsystemmonitor == 0.0 08:04:54 INFO - moztest == 0.7 08:04:54 INFO - mozversion == 1.4 08:04:54 INFO - psutil == 3.1.1 08:04:54 INFO - requests == 1.2.3 08:04:54 INFO - wsgiref == 0.1.2 08:04:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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')]} 08:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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', '-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 0x7f521f101f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac00b0>, '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 0x1ac0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410', '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 08:04:54 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 08:04:54 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 08:04:54 INFO - Using env: {'DISPLAY': ':0', 08:04:54 INFO - 'HOME': '/home/cltbld', 08:04:54 INFO - 'LANG': 'en_US.UTF-8', 08:04:54 INFO - 'LANGUAGE': 'en_US:en', 08:04:54 INFO - 'LOGNAME': 'cltbld', 08:04:54 INFO - 'MAIL': '/var/mail/cltbld', 08:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:54 INFO - 'MOZ_NO_REMOTE': '1', 08:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:54 INFO - 'NO_EM_RESTART': '1', 08:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:54 INFO - 'PWD': '/builds/slave/test', 08:04:54 INFO - 'SHELL': '/bin/bash', 08:04:54 INFO - 'SHLVL': '1', 08:04:54 INFO - 'TERM': 'linux', 08:04:54 INFO - 'TMOUT': '86400', 08:04:54 INFO - 'USER': 'cltbld', 08:04:54 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410', 08:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:54 INFO - '_': '/tools/buildbot/bin/python'} 08:04:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:04:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:04:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:04:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:04:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:04:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:04:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:04:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:04:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:04:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:04:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:04:55 INFO - Cleaning up... 08:04:55 INFO - Return code: 0 08:04:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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')]} 08:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f521f101f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac00b0>, '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 0x1ac0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410', '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 08:04:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:04:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:04:55 INFO - Using env: {'DISPLAY': ':0', 08:04:55 INFO - 'HOME': '/home/cltbld', 08:04:55 INFO - 'LANG': 'en_US.UTF-8', 08:04:55 INFO - 'LANGUAGE': 'en_US:en', 08:04:55 INFO - 'LOGNAME': 'cltbld', 08:04:55 INFO - 'MAIL': '/var/mail/cltbld', 08:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:55 INFO - 'MOZ_NO_REMOTE': '1', 08:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:55 INFO - 'NO_EM_RESTART': '1', 08:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:55 INFO - 'PWD': '/builds/slave/test', 08:04:55 INFO - 'SHELL': '/bin/bash', 08:04:55 INFO - 'SHLVL': '1', 08:04:55 INFO - 'TERM': 'linux', 08:04:55 INFO - 'TMOUT': '86400', 08:04:55 INFO - 'USER': 'cltbld', 08:04:55 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410', 08:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:55 INFO - '_': '/tools/buildbot/bin/python'} 08:04:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:55 INFO - Downloading/unpacking jsonschema 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:04:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 08:04:57 INFO - Downloading/unpacking functools32 (from jsonschema) 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04:57 INFO - Downloading functools32-3.2.3-2.tar.gz 08:04:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:04:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:04:57 INFO - warning: no files found matching '*.txt' 08:04:57 INFO - no previously-included directories found matching 'build' 08:04:57 INFO - no previously-included directories found matching 'dist' 08:04:57 INFO - no previously-included directories found matching '.git*' 08:04:57 INFO - Installing collected packages: jsonschema, functools32 08:04:57 INFO - Running setup.py install for functools32 08:04:57 INFO - warning: no files found matching '*.txt' 08:04:57 INFO - no previously-included directories found matching 'build' 08:04:57 INFO - no previously-included directories found matching 'dist' 08:04:57 INFO - no previously-included directories found matching '.git*' 08:04:57 INFO - Successfully installed jsonschema functools32 08:04:57 INFO - Cleaning up... 08:04:57 INFO - Return code: 0 08:04:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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')]} 08:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f521f101f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac00b0>, '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 0x1ac0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410', '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 08:04: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', 'flake8'] in /builds/slave/test/build 08:04: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 flake8 08:04:57 INFO - Using env: {'DISPLAY': ':0', 08:04:57 INFO - 'HOME': '/home/cltbld', 08:04:57 INFO - 'LANG': 'en_US.UTF-8', 08:04:57 INFO - 'LANGUAGE': 'en_US:en', 08:04:57 INFO - 'LOGNAME': 'cltbld', 08:04:57 INFO - 'MAIL': '/var/mail/cltbld', 08:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:57 INFO - 'MOZ_NO_REMOTE': '1', 08:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:57 INFO - 'NO_EM_RESTART': '1', 08:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:57 INFO - 'PWD': '/builds/slave/test', 08:04:57 INFO - 'SHELL': '/bin/bash', 08:04:57 INFO - 'SHLVL': '1', 08:04:57 INFO - 'TERM': 'linux', 08:04:57 INFO - 'TMOUT': '86400', 08:04:57 INFO - 'USER': 'cltbld', 08:04:57 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410', 08:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:57 INFO - '_': '/tools/buildbot/bin/python'} 08:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:57 INFO - Downloading/unpacking flake8 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:04:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 08:04:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:04:59 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 08:04:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04:59 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 08:04:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:05:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:05:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:05:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:05:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:05:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:05:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:05:00 INFO - no previously-included directories found matching 'docs/_build' 08:05:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:05:00 INFO - Running setup.py install for pep8 08:05:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:05:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:05:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:05:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:05:00 INFO - no previously-included directories found matching 'docs/_build' 08:05:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:05:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:05:00 INFO - Cleaning up... 08:05:00 INFO - Return code: 0 08:05:00 INFO - Running post-action listener: _resource_record_post_action 08:05:00 INFO - Running post-action listener: _start_resource_monitoring 08:05:00 INFO - Starting resource monitoring. 08:05:00 INFO - ##### 08:05:00 INFO - ##### Running install step. 08:05:00 INFO - ##### 08:05:00 INFO - Running pre-action listener: _resource_record_pre_action 08:05:00 INFO - Running main action method: install 08:05:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:00 INFO - Reading from file tmpfile_stdout 08:05:00 INFO - Detecting whether we're running mozinstall >=1.0... 08:05:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:05:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:05:00 INFO - Reading from file tmpfile_stdout 08:05:00 INFO - Output received: 08:05:00 INFO - Usage: mozinstall [options] installer 08:05:00 INFO - Options: 08:05:00 INFO - -h, --help show this help message and exit 08:05:00 INFO - -d DEST, --destination=DEST 08:05:00 INFO - Directory to install application into. [default: 08:05:00 INFO - "/builds/slave/test"] 08:05:00 INFO - --app=APP Application being installed. [default: firefox] 08:05:00 INFO - mkdir: /builds/slave/test/build/application 08:05:00 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'] 08:05:00 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 08:05:16 INFO - Reading from file tmpfile_stdout 08:05:16 INFO - Output received: 08:05:16 INFO - /builds/slave/test/build/application/firefox/firefox 08:05:16 INFO - Running post-action listener: _resource_record_post_action 08:05:16 INFO - ##### 08:05:16 INFO - ##### Running run-tests step. 08:05:16 INFO - ##### 08:05:16 INFO - Running pre-action listener: _resource_record_pre_action 08:05:16 INFO - Running main action method: run_tests 08:05:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:05:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:05:16 INFO - Python 2.7.3 08:05:16 INFO - Return code: 0 08:05:16 INFO - grabbing minidump binary from tooltool 08:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:16 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac00b0>, '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 0x1ac0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:05:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:05:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:05:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:05:16 INFO - Return code: 0 08:05:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:05:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:05:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:05:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:05:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:05:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:05:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:05:17 INFO - Return code: 0 08:05:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] in /builds/slave/test/build 08:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost 08:05:17 INFO - Using env: {'DISPLAY': ':0', 08:05:17 INFO - 'HOME': '/home/cltbld', 08:05:17 INFO - 'LANG': 'en_US.UTF-8', 08:05:17 INFO - 'LANGUAGE': 'en_US:en', 08:05:17 INFO - 'LOGNAME': 'cltbld', 08:05:17 INFO - 'MAIL': '/var/mail/cltbld', 08:05:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:05:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:17 INFO - 'MOZ_NO_REMOTE': '1', 08:05:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:05:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:17 INFO - 'NO_EM_RESTART': '1', 08:05:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:17 INFO - 'PWD': '/builds/slave/test', 08:05:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:05:17 INFO - 'SHELL': '/bin/bash', 08:05:17 INFO - 'SHLVL': '1', 08:05:17 INFO - 'TERM': 'linux', 08:05:17 INFO - 'TMOUT': '86400', 08:05:17 INFO - 'USER': 'cltbld', 08:05:17 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410', 08:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:17 INFO - '_': '/tools/buildbot/bin/python'} 08:05:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] with output_timeout 3600 08:05:17 INFO - mozversion INFO | application_buildid: 20151218062800 08:05:17 INFO - mozversion INFO | application_changeset: ce75ab3d79c631b2880e7894f9fd05d468aee1a5 08:05:17 INFO - mozversion INFO | application_display_name: Nightly 08:05:17 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:05:17 INFO - mozversion INFO | application_name: Firefox 08:05:17 INFO - mozversion INFO | application_remotingname: firefox 08:05:17 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 08:05:17 INFO - mozversion INFO | application_vendor: Mozilla 08:05:17 INFO - mozversion INFO | application_version: 46.0a1 08:05:17 INFO - mozversion INFO | platform_buildid: 20151218062800 08:05:17 INFO - mozversion INFO | platform_changeset: ce75ab3d79c631b2880e7894f9fd05d468aee1a5 08:05:17 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 08:05:17 INFO - mozversion INFO | platform_version: 46.0a1 08:05:17 INFO - 2015-12-18 08:05:17,269 DEBUG : using testdate: 1450454717 08:05:17 INFO - 2015-12-18 08:05:17,269 DEBUG : actual date: 1450454717 08:05:17 INFO - 2015-12-18 08:05:17,278 INFO : starting webserver on 'localhost:58249' 08:05:17 INFO - 2015-12-18 08:05:17,279 INFO : Starting test suite talos-linux64-ix-030 08:05:17 INFO - 2015-12-18 08:05:17,279 INFO : Starting test dromaeo_css 08:05:17 INFO - 2015-12-18 08:05:17,279 DEBUG : operating with platform_type : linux_ 08:05:17 INFO - 2015-12-18 08:05:17,280 INFO : Initialising browser for dromaeo_css test... 08:05:17 INFO - 2015-12-18 08:05:17,295 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDElJQI/profile http://localhost:58249/getInfo.html 08:05:21 INFO - 2015-12-18 08:05:21,600 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:05:21 INFO - 2015-12-18 08:05:21,601 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:05:21 INFO - 2015-12-18 08:05:21,601 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:05:21 INFO - 2015-12-18 08:05:21,601 DEBUG : BROWSER_OUTPUT: __metrics 08:05:21 INFO - 2015-12-18 08:05:21,722 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] 08:05:21 INFO - 2015-12-18 08:05:21,778 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] 08:05:23 INFO - 2015-12-18 08:05:23,015 INFO : Browser initialized. 08:05:23 INFO - 2015-12-18 08:05:23,015 INFO : Running cycle 1/1 for dromaeo_css test... 08:05:23 INFO - 2015-12-18 08:05:23,016 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDElJQI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:05:34 INFO - 2015-12-18 08:05:34,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 150114304 08:05:34 INFO - 2015-12-18 08:05:34,940 DEBUG : BROWSER_OUTPUT: 08:06:26 INFO - 2015-12-18 08:06:26,300 DEBUG : BROWSER_OUTPUT: 1450454786299 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] 08:08:38 INFO - 2015-12-18 08:08:38,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58249/tests/dromaeo/cssquery-ext.html) 08:08:39 INFO - 2015-12-18 08:08:39,718 DEBUG : BROWSER_OUTPUT: RSS: Main: 252657664 08:08:39 INFO - 2015-12-18 08:08:39,719 DEBUG : BROWSER_OUTPUT: 08:11:42 INFO - 2015-12-18 08:11:42,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58249/tests/dromaeo/cssquery-ext.html (next: http://localhost:58249/tests/dromaeo/cssquery-jquery.html) 08:11:42 INFO - 2015-12-18 08:11:42,765 DEBUG : BROWSER_OUTPUT: RSS: Main: 230318080 08:11:42 INFO - 2015-12-18 08:11:42,765 DEBUG : BROWSER_OUTPUT: 08:14:44 INFO - 2015-12-18 08:14:44,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58249/tests/dromaeo/cssquery-mootools.html) 08:14:45 INFO - 2015-12-18 08:14:45,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 232824832 08:14:45 INFO - 2015-12-18 08:14:45,322 DEBUG : BROWSER_OUTPUT: 08:17:47 INFO - 2015-12-18 08:17:47,220 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58249/tests/dromaeo/cssquery-prototype.html) 08:17:47 INFO - 2015-12-18 08:17:47,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 211472384 08:17:47 INFO - 2015-12-18 08:17:47,801 DEBUG : BROWSER_OUTPUT: 08:20:50 INFO - 2015-12-18 08:20:50,442 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58249/tests/dromaeo/cssquery-yui.html) 08:20:51 INFO - 2015-12-18 08:20:51,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 191582208 08:20:51 INFO - 2015-12-18 08:20:51,036 DEBUG : BROWSER_OUTPUT: 08:23:53 INFO - 2015-12-18 08:23:53,437 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58249/tests/dromaeo/cssquery-yui.html (next: http://localhost:58249/tests/dromaeo/cssquery-dojo.html) 08:23:53 INFO - 2015-12-18 08:23:53,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 261758976 08:23:53 INFO - 2015-12-18 08:23:53,695 DEBUG : BROWSER_OUTPUT: 08:23:53 INFO - 2015-12-18 08:23:53,695 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:23:53 INFO - 2015-12-18 08:23:53,695 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:23:53 INFO - 2015-12-18 08:23:53,696 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:23:53 INFO - 2015-12-18 08:23:53,696 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:23:53 INFO - 2015-12-18 08:23:53,696 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2633.789296856251;2733.398652296494;2739.5205838978172;2746.2722378569683;2748.203021123875;4509.323601459782;4610.608098311639;4757.738324392157;4818.975905120474;4823.807047718087;4613.400257966459;4680.368150299709;4731.266653668678;4734;4744.667873248874;4363.629091527224;4387.648988080946;4410.095930334282;4491.034427598082;4512.481064677555;4209.536950935395;4415.20526305265;4448.088141930913;4500.459944806611;4526.569975852305;4242.575742425748;4307.676924230664;4403.823847046115;4425;4439.955600443986;4358;4358.782060896974;4367.6023672424835;4385.605295523418;4414.073044660625;4180.581941805825;4354.934675979863;4365.236083685342;4404.779761011937;4420.602145806861;4610.2623580227;4631.096936097462;4697.154512187805;4787.281907713871;4837.9516204837855;5142.562882155022;5154.639175257734;5155.149400348938;5164.845054648366;5199.66202196856;4865.270209468608;5174.741262936838;5176.8964620707375;5185.714785686786;5186.1442861927735;4690.202665546865;4713.599344055725;4713.9764301178275;4829.13075646387;4835.492273311252;5326.147816349443;5353.544948679328;5395.4604539545735;5399.541039011649;5401.621886467988;5080.212567052113;5119.129747942859;5121.4622464641425;5123.103456895028;5168.121419358718;4850.442199147073;4971.776270067856;4972;5189.532942035235;5216.26972223889;5004.84985450437;5079.619028572872;5110.156824124052;5117.8720531986255;5130.769115389817;5007.84976450707;5039.118154322979;5043.243513472935;5045.949540504622;5048.066107770074;4003.4395184674167;4233.872983810491;4234.576542345741;4235.004773878136;4280.315149576053;3620.3845346291196;3676.613955534684;3682.760620559655;3710.888673339804;3718.0147260975864;4366.716163449366;4371.868843934687;4397.362382454527;4399.912001759947;4434.578715022068;4809.302651115639;5131.820386286462;5144;5146.073706732824;5147.124988751922;4222.2611043067955;4238.491381034296;4320.373545835899;4391.736495810262;4415.602595766396;4492.0791237796175;4495.168393847149;4496.887577810581;4520.412346394947;4530.61489773373;4687;4774.259989701602;4783.856484305476;4785.641076919175;4839.395075615548;4920.45874953762;4921.97539012317;5005.324281221989;5083.237514372726;5130.153524668388;4732.219183834766;4762.071396077731;4764;4805.471398146271;4806.2310030394965;4749.430068391815;4978.5270399312;4987.301777751045;4987.516228902485;5033.672811267403;4951.72765497901;4972.602191824718;5118.053160165381;5181.248718935658;5213.869653258699;4969.925451118308;4988.102141614544;4990.900181996412;4992.2761199626575;5033.798648054037;4640.466346370211;4962.255661650637;4965.8013679452415;4980.302757613865;4980.601551875914;4727.17274476972;4733.053389322218;4839.104765618372;4918.311436398979;4940.629452790983;5049.924251136309;5056.064628043824;5058.570021548209;5061.9493805061475;5064.063148317573;4658;4929.2359684248995;4935.629827763004;4944.381952255968;4998.750062496933 08:23:53 INFO - 2015-12-18 08:23:53,697 DEBUG : BROWSER_OUTPUT: |1;ext.html;568.8606291458595;570.3925319534695;575.9913601295979;576.0753989846297;578.9565782566307;24308.87845560772;32935.17662058447;33699.83150084252;33724.83137584315;33766.83116584414;37988.43017354742;38427.807860960726;38544;38565;38589.614103858956;6849.212340580847;6948.235694073673;7688.308052275294;7911.485753426037;7936.44444888858;9909.603615855358;10238.385696858175;10238.488075596228;10246.333988290737;10252.794944101113;9779.853302200472;9921.90078099217;9926;9927.851082233736;9927.900720992806;7091.822704432405;7270.963645181793;9793.55928983194;9934.80130397388;10281.588736450607;9760.4631745254;9920.603175872957;9926.106650401498;9926.652567160114;9928.404295742206;35331;35711.82144089289;35841;35846;35862.64137358619;2943.440746258204;2949.970500294991;2999.2351950252546;3118.8284644344553;3339.2820543583002;27496;27578.44843103147;27712.445751084866;27939.86030069857;27991.440171196464;3410.4543273076188;3419.64093770153;3465.1163953192026;3483.3033393321184;3519.595246546629;212012;213492;213518;214649.9267503668;214781;48727.512724873006;50444.24333634999;50791;50845;50861;42823.571764282584;59685.70157149187;61657;61680.07479887805;61682.38317616856;13468.93265533666;13657;13689.178649281075;13697.726045479034;13698.726025479435;10968.725781855357;11050.392228427352;11067.446627668583;11077.72305692348;11079.50142243601;17046.403375881786;17225.1387430628;17240.568985775455;17258.482245532403;17264.568385790204;7224.783256502314;7337.321877514775;7445.798306728159;7462.403007759366;7521.5111017783665;821.4988856797349;829.2246749289434;836.7782537627412;893.6246776353947;896.4307664633005;25561;27136.864315678296;28632.284192894927;29051.273718157216;29067;1012.9493525323704;1024.364893765855;1037.870266216723;1063.9466927741635;1068.6740544133959;12852.678683032813;12934.59133253132;12950.740985180244;12956.80564791529;13032;248552;250136;251265;252495;252655;42063.78968105201;42326;42347.57652423436;42366.36450453246;42376.36435453471;1193.2899924544881;1229.846269216348;1236.394166858233;1241.472374240944;1246.856611489672;23859.403514912265;24512.632310515;24689.753102468745;24826.255212343658;24938.62592061084;37235.627643723215;37519.81240093782;37549.81225093857;37585.81207093947;37654.2469150621;224135;241228;243403;243602;243691;23244.418889527897;26731.599026014235;27364.179074627795;27518;27750;31049.534256986615;31157.688423116386;31459.213519662193;31751.936124151856;31813.04560863085;27234.72765272322;27422.45155096847;27670.5849412263;27676.308092297855;28046;25739.613905791055;26845.194644160707;31600.367992640477;31621.36757264796;32033.359332813678;28237.858810706635;28434.85782571074;28767.568486473137;30477.08568742941;30518.694813051585;25953.7023148838;26903.86548067247;27122;27295.317617059733;27448;21568.137274508845;21704.67442988325;21988.89005554962;22073.117075316808;22126 08:23:53 INFO - 2015-12-18 08:23:53,697 DEBUG : BROWSER_OUTPUT: |2;jquery.html;311.73813996243166;315.71743289755653;319.5446488753527;321.48080849428175;322.8321272938072;11969;12379.504819807196;14751.77872331916;15142.621434464143;15469.45856895009;14294.71410571788;14358.784618230735;14564.563063108124;14598.416063357454;14627.780583291233;4414.933775993362;4677.976610116944;4695.530446955311;4827.493113223114;4890.853274401756;4844.709317440947;4893.4617192108835;4895.534924182215;4897.191963326047;4899.8040078397;4736.2895565665085;4831.492693267209;4847.75761211938;4866.270059491087;4892.5596696297325;4790.23356262998;4838.322634831109;4839.564439200453;4841.515848415148;4843.636727245435;4279.122779830159;4300.892477688051;4302.677299202541;4316.201502722007;4321.027768752006;17889;18252.45242642723;18413.171407286703;18622.813771862242;19323.227070917146;1662.7588999595112;1732.6274850907116;1922.3464022232367;1945.3191383015974;1965.2335589120255;8456.365772567082;8566.914330856674;8740.388172827905;10989.560417583287;11587.652370428901;1702.8467437930647;1711.1853088480807;1762.215813962787;1767.08994867642;1833.5966087460738;52377.2143417849;54566;54644;54893.9999999996;55898.16152757712;9285.860712089325;9302.488363140092;9349.036702292595;9389.873215214082;9394.577244024036;10500;10814.729631759268;11794.941025294818;11813.054955603531;12001.63995080149;6385.201849768779;6520.869582608416;6700.396964273239;6723.966380168165;6825.044493770876;6365.2998170201245;6385.48916086712;6497.577657452345;6509.674516274167;6552.180977377828;4008.038070862972;4053.4751900222077;4084.9795751021056;4113.465249517543;4114.382842573638;1664.4923298393865;1700.8554272886695;1718.0328523840133;1725.6462425202803;1731.9945357915633;829.7718127514861;846.5851732650957;904.5341649050744;908.9681861134961;956.4930586789013;14554.981151319305;15013;15846.603834903988;16607.169641517874;16951.491455256117;759.9924000759921;850.6852464588142;894.552723638181;958.2956526952685;994.105305225303;8022.077461092049;8833.55832208387;9326.860097098548;9331.766705832408;9490.145886870216;480480;493364;497847;498086;501430;52019.47980520222;59784.103238451455;60178.39821601728;70920.29079709137;72197.63901180566;1046.853440518328;1061.0927656853435;1071.5499490214129;1071.8660167479065;1072.822984207597;13392.589333919988;13599.116057456235;14035.438582456587;14130.717385652435;14142.575722728334;29849.5522567166;31962.20094497563;32822.343553128325;32885.83557082295;33133.502997454576;39113.41329879997;39187.020324492114;39355.60644393634;42514;45113.77443112763;13226.537071202461;13435.193888366339;13477;13500.054996150175;14392;17458.47624571265;17788.55528611795;18101.637967240316;18190.81809181944;18266.817331827042;14443.85556144425;14818.40726370933;15112.773308400163;15234;15265.6183595411;14340.924430667534;14431.711365772835;14532.709345813237;14862.108273503625;15084.622884427978;14218.502352417616;14246.145231286157;14619.12285262845;14718.116912985255;15010.624734381729;13520.932395338354;13559.322033898068;13731.382087805872;13751.243681597609;13822.37799299014;14053.648658783612;14365.569032929028;14631.487897923522;14776.926115369784;14929.776053359426 08:23:53 INFO - 2015-12-18 08:23:53,697 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1416.1220043572987;1639.5327331710464;1654.7517872319152;1693.2211182855885;1718.5617667494787;5834.124881267807;6814.863702725948;6940.895886561706;6992.8601427971535;7010.6845191966295;6858.828529286758;6982.546134501266;6985.336393042666;6989.056477375553;7000.684969176386;2053.4660988143114;2088.937331880046;2090.5087304483436;2091.801278878504;2092.790720927903;2099.9685004724943;2106.610277098734;2121.459027947879;2130.3289463818924;2142.2823354176294;2029.3810387831707;2035.9592808143827;2063.1850419084453;2064.9896750516227;2065.215218217083;2085.708000879878;2112.271266413085;2114.164904862586;2117.4388786971463;2117.7035215069827;2066.2045112631595;2090.2997495838913;2101.5796840631933;2103.4741314671332;2107.599556084339;7138.179109402433;7224.349808517206;7224.7110115595315;7239.348458638695;7244.058272424604;4183.728057676241;4257.680673949466;4271.487421509408;4291.399204111427;4299.398084268205;2737.072301247716;2758.586212068186;2790.8185967912023;2814.802963792535;2824.7175282471794;860.9526476043815;1683.3266693322646;1726.0161707826544;1767.0899486764326;1772.521419216817;9670.274729395323;9769.267304952156;9796.069373409586;9815.214782817358;9825.115739583473;3752.2683076799763;3752.45589389537;3809.4095415210686;3810.2760475510117;3925.2345792570177;7948.960255198687;7961.004874390701;7961.1242763295995;7963.800904977422;7982.481138725964;4271.530131685512;4288.957110428856;4291.957080429218;4294.033842385501;4299.312110062375;3255.0723043932367;3357.093584732109;3801.6008319126095;3961.6830653547645;3964.900877478086;3273.0998975281514;3273.672632736755;3273.852676629557;3302.7688061835443;3347.1966727985596;992.3500107429501;1013.3058854684565;1014.123870838942;1028.3675539543126;1031.3811712972156;1137.3460260350332;1137.374444055766;1143.2911594811271;1161.9825702614467;1163.168334640736;6853.211880633691;6867;6876.381125698711;6892.931070689229;6901.275366086589;414.8071146916698;422.2757970081264;423.0903557351657;427.76045414567943;428.1501220078142;5333.6266461348105;5377.838664840061;5383.273258110184;5390.191471279261;5397.78408863641;7390.778276651601;7394.408447324201;7481.8877716834295;8577.571121443903;8745.256653184551;8259.752207433787;8445.915540844635;8507.53208573522;8520.488770673655;8525.57372131391;6721.428678562279;6789.355011273921;6837.9316206839285;6889.655517224119;6912.965435172792;6820.488463365366;6864.553804002724;6865.931340686529;6874.243833178246;6896.517243792886;7365.705371785283;7678.232176782277;7679.846403072019;7691.30778229962;7862.72480463181;7784.84430311402;7834.334081603128;7967.203279671987;8113.594320283844;8122.1065682776025;5284.497972692588;5893.557983151367;6346.968265158829;6390.7443702251385;6405.93594064072;6690.13028306317;6729.865402692017;6785.626790526569;6834.453243740588;6848.7260509579055;6266.404691554295;6284.340144284967;6527.15147030883;6548.8362790930605;6637.336266373324;6082.72627731762;6453.483721302378;6453.677316134268;6476.352364763486;6576.243731970693;6512.869742605027;6553.803385898431;6557.180352455943;6558.639274839929;6572.671366431755;5330.866728331823;5346.732663366738;5348.839534813962;5351.438098999549;5371.919421208607;6180.258368995749;6199.969000154971;6210.068489726577;6215.81352559424;6222.408871157233 08:23:53 INFO - 2015-12-18 08:23:53,697 DEBUG : BROWSER_OUTPUT: |4;prototype.html;298.2781668362562;303.47801780936794;305.39836522051576;306.1092221635041;306.9907902762917;5306.92039619406;5322.760475778589;5327.307450031495;5330.546903513201;5348.171033489805;5242.7640756165965;5249.632525723201;5259.8422047338645;5265.973670131644;5273.288106105674;3926.803659817012;4141.068259641586;4143.979280103596;4147.605977432139;4151.045259590296;4026.8187931543002;4056.9188616227657;4104.610062044101;4133.3386658134705;4149.298787497127;4075.5924407559155;4092.1406504634065;4099.036726369316;4103.240900433414;4104.220198162355;3853.1523064925673;3958.0698535844053;3975.4434379186937;4106.8562600309;4115.711900166974;3614.9096272593397;3622.855085796565;3626.746127771057;3632.727545434103;3636.672699457035;5095.031943930679;5101.081805275049;5106.617003724736;5120.411152717448;5129.256257842592;4720.858374248778;4733.881652958669;4738.526147385269;4739.502352252998;4739.857804265843;5432.75552600134;5557.972210138963;5570.693611851347;5571.749271282802;5586.106223004341;3966.3852102924093;3976.7812770297624;3978.1645854370618;3978.9602103978877;3983;5861.17943487912;5864.970675146597;5865.208196893407;5868.530517558585;5872.853178670524;4072.063425412172;4085.6935729820384;4086.4483294755423;4091.57038510958;4102.056526998747;4043.959560404417;4144.5233798113;4157.625813676784;4160.916781664349;4175.54069052404;4720.95279047212;4733.195356789354;4736.668433209642;4739.95260047402;4740.146773580788;5565.471280228372;5578.135389014709;5578.525825304813;5580.804671836466;5583.3858275589655;1426.5506365494837;1437.4393986345333;1437.6837095838898;1438.173050495969;1438.180237264749;992.1120597065586;994.28908330544;996.2478328861663;996.7009897030862;1016.5323950982483;4895.265710143507;4903.656744027955;4906.803727850846;4914.041761856475;4915.3855768029;5777.30672319316;5783.566232532577;5784.045632470596;5784.855378615484;5787.8553036174435;4901.950980490221;4902.779374928136;4905.288733133676;4908.533689299511;4909.5090490950615;3040.3159289160203;3081.337512434837;3112.25305926576;3117.7505799535984;3120.1731541141617;5447.264619276426;5492.203630473638;5504.366997795225;5505;5506.311711036121;6003.159557661931;6015.278166619946;6022.247219097613;6022.638641681513;6024.096385542116;5493.23094766733;5503.724813759296;5507.063799154073;5507.421720719267;5512.2558454608115;5674.460926212003;5825.097109947965;5830.737616807169;5840.386759390203;5841.649501029951;5667.461591148999;5671.979043771996;5695.971520142372;5700.572457065654;5703.315602127771;5484.533814625802;5488.945110549003;5496.065668836387;5499.312585926759;5500.724963751876;3881.4954055972544;3930.6265904739003;3970.3448930926074;3975.741576797499;3991.261616600938;5822.126680997715;5822.98097832886;5826.563007774519;5828.825135245949;5831.300243970751;5580.5535557156145;5619.775208991595;5622.522085622768;5624.550035997192;5629.408912064175;5574.637648552831;5611.130274807411;5611.298587676541;5615.691136987505;5630.943690563042;5350.705711185922;5488.204210389551;5493.066178749542;5500.092484739973;5503.587230957774;5436.429174936733;5575.135853942646;5641.041023026013;5656.321241451053;5658.151277308437;5394.703291319015;5506.476884695948;5541;5544.279243698294;5545.445455454423 08:23:53 INFO - 2015-12-18 08:23:53,697 DEBUG : BROWSER_OUTPUT: |5;yui.html;560.6075746977115;619.5941658213872;631.5452873930769;663.5521023309267;664.2759392262436;10190.184785217183;10267.127294180003;10389.844152337702;10405.11556517697;10448.477576121191;10761.946190269056;11424.771504569904;11483.138764592648;11490.482928268228;11510.482028308725;626.3642402960999;633.7116611941556;774.8372841703249;780.3406121827076;800.3437181511134;771.4946709905021;781.5467029123095;785.6621652689341;786.2491320788633;787.2009909941414;642.299893116503;828.7099515169702;835.5028757889077;835.6197929941862;835.9122292159327;647.9481641468672;798.1220657277007;810.8986376702912;811.663159788687;812.0904586862752;605.6396444115744;606.3178923710825;606.336062012096;606.4935778624854;606.6996836565884;11034.062104721108;11035.117190624731;11045.779084418267;11050.723731906766;11062.889371106266;10571.682849514527;11328.886711132865;11352.772944541146;11695.590654327058;11754.118441116865;8784.388613713687;8942;9076.63693452261;9182.954085229598;9223.07769223079;3225.6290526589273;3236.579244698174;3267.068885367659;3271.9018429446915;3285.96714032859;37013.074673133386;37291;37411;37477.81261093704;37755;8714.9977752558;8930.86603700945;8981;9002.279817614706;9020.503872286956;16037.599060023593;16112.516624501284;16118;16128.435504757277;16140.273687684083;6090.573659843769;6160.845978850564;6277.811665650038;6310.495160387158;6348.269948955837;3495.8426870790877;3592.604813470516;3603.135247540624;3614.7469677122876;3654.835532401048;2507.8620675863003;2550.4516528946365;2553.527597394488;2561;2579.6775403074616;452.2334642780521;458.38347422716396;471.74997251456784;472.5321931288069;478.2778005212085;463.1616773639723;470.2217829492196;546.546366515791;552.199310999053;596.8239369386041;7358.96320518394;7391.445641576904;7412.740554080581;7635.809104772314;7645.961770191114;547.2038184441628;565.8076254073635;570.6519023395808;571.3943220186616;574.6552068758712;3395.813230272359;3553.964460355415;3609.314230296235;3860.4788353571907;3997.6801855851463;45292.54707452883;47240.291395629094;47242.52757472381;47362.289565656545;47438.28842567364;41344;41762;42279.788601056796;42617.57382426136;43057.784711076245;38080.38583606936;38600.80699596484;38924.416133758015;39431.80284098619;40178.799106004284;7846.882296765667;7947.205279472007;7955.880661790194;8159.102498725254;8175.182481751777;27858.303542411602;28342.291442714097;28694.282642934093;28810.567841481974;29876.103716888527;33594.160145996546;33692.49461258132;34090.488642670876;36060.27879442449;36187;9482.478463684563;10056.89943100589;10097.44464054484;10217.182625389802;10502.894971050191;10992.477675117452;11058.944705276745;11152.665420037412;11156.721081973015;11343.773124537629;10284.331518451278;10420.218483613608;10420.531076101443;10471.476426178508;10908.454577270946;9481.620735170516;9792.706218813448;10010.399376037461;10110.49447527606;10222.13111885498;10166.898331016891;10679.733006674895;10761.623343182951;10785.083267922315;10880.401577913291;8256.422050456411;8350.83298334042;8548.444351117158;8571.914280857112;8906.287497000354;7695.576743279174;8201.753947381589;8383.538905360263;8555.272801811916;8645.654173832976 08:23:53 INFO - 2015-12-18 08:23:53,699 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:23:53 INFO - 2015-12-18 08:23:53,699 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:23:53 INFO - 2015-12-18 08:23:53,699 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,903 08:23:53 INFO - 2015-12-18 08:23:53,699 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:23:53 INFO - 2015-12-18 08:23:53,699 DEBUG : BROWSER_OUTPUT: __startTimestamp1450455833689__endTimestamp 08:23:53 INFO - 2015-12-18 08:23:53,699 DEBUG : BROWSER_OUTPUT: 08:23:53 INFO - 2015-12-18 08:23:53,699 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:23:53 INFO - 2015-12-18 08:23:53,700 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:23:53 INFO - 2015-12-18 08:23:53,700 DEBUG : BROWSER_OUTPUT: 08:23:53 INFO - 2015-12-18 08:23:53,700 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4694.85 Median:4805.47 stddev:505.08 (10.5%) stddev-sans-first:480.05 08:23:53 INFO - 2015-12-18 08:23:53,700 DEBUG : BROWSER_OUTPUT: Values: 2633.8 2733.4 2739.5 2746.3 2748.2 4509.3 4610.6 4757.7 4819.0 4823.8 4613.4 4680.4 4731.3 4734.0 4744.7 4363.6 4387.6 4410.1 4491.0 4512.5 4209.5 4415.2 4448.1 4500.5 4526.6 4242.6 4307.7 4403.8 4425.0 4440.0 4358.0 4358.8 4367.6 4385.6 4414.1 4180.6 4354.9 4365.2 4404.8 4420.6 4610.3 4631.1 4697.2 4787.3 4838.0 5142.6 5154.6 5155.1 5164.8 5199.7 4865.3 5174.7 5176.9 5185.7 5186.1 4690.2 4713.6 4714.0 4829.1 4835.5 5326.1 5353.5 5395.5 5399.5 5401.6 5080.2 5119.1 5121.5 5123.1 5168.1 4850.4 4971.8 4972.0 5189.5 5216.3 5004.8 5079.6 5110.2 5117.9 5130.8 5007.8 5039.1 5043.2 5045.9 5048.1 4003.4 4233.9 4234.6 4235.0 4280.3 3620.4 3676.6 3682.8 3710.9 3718.0 4366.7 4371.9 4397.4 4399.9 4434.6 4809.3 5131.8 5144.0 5146.1 5147.1 4222.3 4238.5 4320.4 4391.7 4415.6 4492.1 4495.2 4496.9 4520.4 4530.6 4687.0 4774.3 4783.9 4785.6 4839.4 4920.5 4922.0 5005.3 5083.2 5130.2 4732.2 4762.1 4764.0 4805.5 4806.2 4749.4 4978.5 4987.3 4987.5 5033.7 4951.7 4972.6 5118.1 5181.2 5213.9 4969.9 4988.1 4990.9 4992.3 5033.8 4640.5 4962.3 4965.8 4980.3 4980.6 4727.2 4733.1 4839.1 4918.3 4940.6 5049.9 5056.1 5058.6 5061.9 5064.1 4658.0 4929.2 4935.6 4944.4 4998.8 08:23:53 INFO - 2015-12-18 08:23:53,700 DEBUG : BROWSER_OUTPUT: 08:23:53 INFO - 2015-12-18 08:23:53,700 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38601.24 Median:16005.22 stddev:61185.23 (382.3%) stddev-sans-first:61290.23 08:23:53 INFO - 2015-12-18 08:23:53,700 DEBUG : BROWSER_OUTPUT: Values: 568.9 570.4 576.0 576.1 579.0 24308.9 32935.2 33699.8 33724.8 33766.8 37988.4 38427.8 38544.0 38565.0 38589.6 6849.2 6948.2 7688.3 7911.5 7936.4 9909.6 10238.4 10238.5 10246.3 10252.8 9779.9 9921.9 9926.0 9927.9 9927.9 7091.8 7271.0 9793.6 9934.8 10281.6 9760.5 9920.6 9926.1 9926.7 9928.4 35331.0 35711.8 35841.0 35846.0 35862.6 2943.4 2950.0 2999.2 3118.8 3339.3 27496.0 27578.4 27712.4 27939.9 27991.4 3410.5 3419.6 3465.1 3483.3 3519.6 212012.0 213492.0 213518.0 214649.9 214781.0 48727.5 50444.2 50791.0 50845.0 50861.0 42823.6 59685.7 61657.0 61680.1 61682.4 13468.9 13657.0 13689.2 13697.7 13698.7 10968.7 11050.4 11067.4 11077.7 11079.5 17046.4 17225.1 17240.6 17258.5 17264.6 7224.8 7337.3 7445.8 7462.4 7521.5 821.5 829.2 836.8 893.6 896.4 25561.0 27136.9 28632.3 29051.3 29067.0 1012.9 1024.4 1037.9 1063.9 1068.7 12852.7 12934.6 12950.7 12956.8 13032.0 248552.0 250136.0 251265.0 252495.0 252655.0 42063.8 42326.0 42347.6 42366.4 42376.4 1193.3 1229.8 1236.4 1241.5 1246.9 23859.4 24512.6 24689.8 24826.3 24938.6 37235.6 37519.8 37549.8 37585.8 37654.2 224135.0 241228.0 243403.0 243602.0 243691.0 23244.4 26731.6 27364.2 27518.0 27750.0 31049.5 31157.7 31459.2 31751.9 31813.0 27234.7 27422.5 27670.6 27676.3 28046.0 25739.6 26845.2 31600.4 31621.4 32033.4 28237.9 28434.9 28767.6 30477.1 30518.7 25953.7 26903.9 27122.0 27295.3 27448.0 21568.1 21704.7 21988.9 22073.1 22126.0 08:23:53 INFO - 2015-12-18 08:23:53,700 DEBUG : BROWSER_OUTPUT: 08:23:53 INFO - 2015-12-18 08:23:53,700 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26502.53 Median:16140.87 stddev:80524.63 (498.9%) stddev-sans-first:80726.51 08:23:53 INFO - 2015-12-18 08:23:53,702 DEBUG : BROWSER_OUTPUT: Values: 311.7 315.7 319.5 321.5 322.8 11969.0 12379.5 14751.8 15142.6 15469.5 14294.7 14358.8 14564.6 14598.4 14627.8 4414.9 4678.0 4695.5 4827.5 4890.9 4844.7 4893.5 4895.5 4897.2 4899.8 4736.3 4831.5 4847.8 4866.3 4892.6 4790.2 4838.3 4839.6 4841.5 4843.6 4279.1 4300.9 4302.7 4316.2 4321.0 17889.0 18252.5 18413.2 18622.8 19323.2 1662.8 1732.6 1922.3 1945.3 1965.2 8456.4 8566.9 8740.4 10989.6 11587.7 1702.8 1711.2 1762.2 1767.1 1833.6 52377.2 54566.0 54644.0 54894.0 55898.2 9285.9 9302.5 9349.0 9389.9 9394.6 10500.0 10814.7 11794.9 11813.1 12001.6 6385.2 6520.9 6700.4 6724.0 6825.0 6365.3 6385.5 6497.6 6509.7 6552.2 4008.0 4053.5 4085.0 4113.5 4114.4 1664.5 1700.9 1718.0 1725.6 1732.0 829.8 846.6 904.5 909.0 956.5 14555.0 15013.0 15846.6 16607.2 16951.5 760.0 850.7 894.6 958.3 994.1 8022.1 8833.6 9326.9 9331.8 9490.1 480480.0 493364.0 497847.0 498086.0 501430.0 52019.5 59784.1 60178.4 70920.3 72197.6 1046.9 1061.1 1071.5 1071.9 1072.8 13392.6 13599.1 14035.4 14130.7 14142.6 29849.6 31962.2 32822.3 32885.8 33133.5 39113.4 39187.0 39355.6 42514.0 45113.8 13226.5 13435.2 13477.0 13500.1 14392.0 17458.5 17788.6 18101.6 18190.8 18266.8 14443.9 14818.4 15112.8 15234.0 15265.6 14340.9 14431.7 14532.7 14862.1 15084.6 14218.5 14246.1 14619.1 14718.1 15010.6 13520.9 13559.3 13731.4 13751.2 13822.4 14053.6 14365.6 14631.5 14776.9 14929.8 08:23:53 INFO - 2015-12-18 08:23:53,702 DEBUG : BROWSER_OUTPUT: 08:23:53 INFO - 2015-12-18 08:23:53,702 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4964.56 Median:5988.14 stddev:2549.64 (42.6%) stddev-sans-first:2542.84 08:23:53 INFO - 2015-12-18 08:23:53,702 DEBUG : BROWSER_OUTPUT: Values: 1416.1 1639.5 1654.8 1693.2 1718.6 5834.1 6814.9 6940.9 6992.9 7010.7 6858.8 6982.5 6985.3 6989.1 7000.7 2053.5 2088.9 2090.5 2091.8 2092.8 2100.0 2106.6 2121.5 2130.3 2142.3 2029.4 2036.0 2063.2 2065.0 2065.2 2085.7 2112.3 2114.2 2117.4 2117.7 2066.2 2090.3 2101.6 2103.5 2107.6 7138.2 7224.3 7224.7 7239.3 7244.1 4183.7 4257.7 4271.5 4291.4 4299.4 2737.1 2758.6 2790.8 2814.8 2824.7 861.0 1683.3 1726.0 1767.1 1772.5 9670.3 9769.3 9796.1 9815.2 9825.1 3752.3 3752.5 3809.4 3810.3 3925.2 7949.0 7961.0 7961.1 7963.8 7982.5 4271.5 4289.0 4292.0 4294.0 4299.3 3255.1 3357.1 3801.6 3961.7 3964.9 3273.1 3273.7 3273.9 3302.8 3347.2 992.4 1013.3 1014.1 1028.4 1031.4 1137.3 1137.4 1143.3 1162.0 1163.2 6853.2 6867.0 6876.4 6892.9 6901.3 414.8 422.3 423.1 427.8 428.2 5333.6 5377.8 5383.3 5390.2 5397.8 7390.8 7394.4 7481.9 8577.6 8745.3 8259.8 8445.9 8507.5 8520.5 8525.6 6721.4 6789.4 6837.9 6889.7 6913.0 6820.5 6864.6 6865.9 6874.2 6896.5 7365.7 7678.2 7679.8 7691.3 7862.7 7784.8 7834.3 7967.2 8113.6 8122.1 5284.5 5893.6 6347.0 6390.7 6405.9 6690.1 6729.9 6785.6 6834.5 6848.7 6266.4 6284.3 6527.2 6548.8 6637.3 6082.7 6453.5 6453.7 6476.4 6576.2 6512.9 6553.8 6557.2 6558.6 6572.7 5330.9 5346.7 5348.8 5351.4 5371.9 6180.3 6200.0 6210.1 6215.8 6222.4 08:23:53 INFO - 2015-12-18 08:23:53,702 DEBUG : BROWSER_OUTPUT: 08:23:53 INFO - 2015-12-18 08:23:53,702 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4646.30 Median:5290.10 stddev:1362.76 (25.8%) stddev-sans-first:1326.93 08:23:53 INFO - 2015-12-18 08:23:53,702 DEBUG : BROWSER_OUTPUT: Values: 298.3 303.5 305.4 306.1 307.0 5306.9 5322.8 5327.3 5330.5 5348.2 5242.8 5249.6 5259.8 5266.0 5273.3 3926.8 4141.1 4144.0 4147.6 4151.0 4026.8 4056.9 4104.6 4133.3 4149.3 4075.6 4092.1 4099.0 4103.2 4104.2 3853.2 3958.1 3975.4 4106.9 4115.7 3614.9 3622.9 3626.7 3632.7 3636.7 5095.0 5101.1 5106.6 5120.4 5129.3 4720.9 4733.9 4738.5 4739.5 4739.9 5432.8 5558.0 5570.7 5571.7 5586.1 3966.4 3976.8 3978.2 3979.0 3983.0 5861.2 5865.0 5865.2 5868.5 5872.9 4072.1 4085.7 4086.4 4091.6 4102.1 4044.0 4144.5 4157.6 4160.9 4175.5 4721.0 4733.2 4736.7 4740.0 4740.1 5565.5 5578.1 5578.5 5580.8 5583.4 1426.6 1437.4 1437.7 1438.2 1438.2 992.1 994.3 996.2 996.7 1016.5 4895.3 4903.7 4906.8 4914.0 4915.4 5777.3 5783.6 5784.0 5784.9 5787.9 4902.0 4902.8 4905.3 4908.5 4909.5 3040.3 3081.3 3112.3 3117.8 3120.2 5447.3 5492.2 5504.4 5505.0 5506.3 6003.2 6015.3 6022.2 6022.6 6024.1 5493.2 5503.7 5507.1 5507.4 5512.3 5674.5 5825.1 5830.7 5840.4 5841.6 5667.5 5672.0 5696.0 5700.6 5703.3 5484.5 5488.9 5496.1 5499.3 5500.7 3881.5 3930.6 3970.3 3975.7 3991.3 5822.1 5823.0 5826.6 5828.8 5831.3 5580.6 5619.8 5622.5 5624.6 5629.4 5574.6 5611.1 5611.3 5615.7 5630.9 5350.7 5488.2 5493.1 5500.1 5503.6 5436.4 5575.1 5641.0 5656.3 5658.2 5394.7 5506.5 5541.0 5544.3 5545.4 08:23:53 INFO - 2015-12-18 08:23:53,702 DEBUG : BROWSER_OUTPUT: 08:23:53 INFO - 2015-12-18 08:23:53,703 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11582.02 Median:42837.68 stddev:12852.76 (30.0%) stddev-sans-first:12862.16 08:23:53 INFO - 2015-12-18 08:23:53,704 DEBUG : BROWSER_OUTPUT: Values: 560.6 619.6 631.5 663.6 664.3 10190.2 10267.1 10389.8 10405.1 10448.5 10761.9 11424.8 11483.1 11490.5 11510.5 626.4 633.7 774.8 780.3 800.3 771.5 781.5 785.7 786.2 787.2 642.3 828.7 835.5 835.6 835.9 647.9 798.1 810.9 811.7 812.1 605.6 606.3 606.3 606.5 606.7 11034.1 11035.1 11045.8 11050.7 11062.9 10571.7 11328.9 11352.8 11695.6 11754.1 8784.4 8942.0 9076.6 9183.0 9223.1 3225.6 3236.6 3267.1 3271.9 3286.0 37013.1 37291.0 37411.0 37477.8 37755.0 8715.0 8930.9 8981.0 9002.3 9020.5 16037.6 16112.5 16118.0 16128.4 16140.3 6090.6 6160.8 6277.8 6310.5 6348.3 3495.8 3592.6 3603.1 3614.7 3654.8 2507.9 2550.5 2553.5 2561.0 2579.7 452.2 458.4 471.7 472.5 478.3 463.2 470.2 546.5 552.2 596.8 7359.0 7391.4 7412.7 7635.8 7646.0 547.2 565.8 570.7 571.4 574.7 3395.8 3554.0 3609.3 3860.5 3997.7 45292.5 47240.3 47242.5 47362.3 47438.3 41344.0 41762.0 42279.8 42617.6 43057.8 38080.4 38600.8 38924.4 39431.8 40178.8 7846.9 7947.2 7955.9 8159.1 8175.2 27858.3 28342.3 28694.3 28810.6 29876.1 33594.2 33692.5 34090.5 36060.3 36187.0 9482.5 10056.9 10097.4 10217.2 10502.9 10992.5 11058.9 11152.7 11156.7 11343.8 10284.3 10420.2 10420.5 10471.5 10908.5 9481.6 9792.7 10010.4 10110.5 10222.1 10166.9 10679.7 10761.6 10785.1 10880.4 8256.4 8350.8 8548.4 8571.9 8906.3 7695.6 8201.8 8383.5 8555.3 8645.7 08:23:53 INFO - 2015-12-18 08:23:53,704 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:23:53 INFO - 2015-12-18 08:23:53,704 DEBUG : BROWSER_OUTPUT: 08:23:54 INFO - 2015-12-18 08:23:54,461 INFO : Browser exited with error code: 0 08:23:54 INFO - 2015-12-18 08:23:54,482 INFO : Completed test dromaeo_css (00:18:37) 08:23:54 INFO - 2015-12-18 08:23:54,483 INFO : Starting test kraken 08:23:54 INFO - 2015-12-18 08:23:54,483 DEBUG : operating with platform_type : linux_ 08:23:54 INFO - 2015-12-18 08:23:54,483 INFO : Initialising browser for kraken test... 08:23:54 INFO - 2015-12-18 08:23:54,489 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZnthfJ/profile http://localhost:58249/getInfo.html 08:23:59 INFO - 2015-12-18 08:23:59,002 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:23:59 INFO - 2015-12-18 08:23:59,003 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:23:59 INFO - 2015-12-18 08:23:59,003 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:23:59 INFO - 2015-12-18 08:23:59,003 DEBUG : BROWSER_OUTPUT: __metrics 08:23:59 INFO - 2015-12-18 08:23:59,119 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] 08:23:59 INFO - 2015-12-18 08:23:59,196 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] 08:23:59 INFO - 2015-12-18 08:23:59,485 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 08:24:00 INFO - 2015-12-18 08:24:00,159 INFO : Browser initialized. 08:24:00 INFO - 2015-12-18 08:24:00,160 INFO : Running cycle 1/1 for kraken test... 08:24:00 INFO - 2015-12-18 08:24:00,160 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZnthfJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:24:12 INFO - 2015-12-18 08:24:12,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 147714048 08:24:12 INFO - 2015-12-18 08:24:12,062 DEBUG : BROWSER_OUTPUT: 08:24:14 INFO - 2015-12-18 08:24:14,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58249/tests/kraken/driver.html?testName=audio-beat-detection) 08:24:15 INFO - 2015-12-18 08:24:15,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 183291904 08:24:15 INFO - 2015-12-18 08:24:15,249 DEBUG : BROWSER_OUTPUT: 08:24:17 INFO - 2015-12-18 08:24:17,971 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58249/tests/kraken/driver.html?testName=audio-dft) 08:24:18 INFO - 2015-12-18 08:24:18,546 DEBUG : BROWSER_OUTPUT: RSS: Main: 172564480 08:24:18 INFO - 2015-12-18 08:24:18,547 DEBUG : BROWSER_OUTPUT: 08:24:21 INFO - 2015-12-18 08:24:21,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58249/tests/kraken/driver.html?testName=audio-fft) 08:24:22 INFO - 2015-12-18 08:24:22,124 DEBUG : BROWSER_OUTPUT: RSS: Main: 158158848 08:24:22 INFO - 2015-12-18 08:24:22,125 DEBUG : BROWSER_OUTPUT: 08:24:24 INFO - 2015-12-18 08:24:24,141 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58249/tests/kraken/driver.html?testName=audio-oscillator) 08:24:24 INFO - 2015-12-18 08:24:24,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 160935936 08:24:24 INFO - 2015-12-18 08:24:24,715 DEBUG : BROWSER_OUTPUT: 08:24:26 INFO - 2015-12-18 08:24:26,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:24:27 INFO - 2015-12-18 08:24:27,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 163201024 08:24:27 INFO - 2015-12-18 08:24:27,497 DEBUG : BROWSER_OUTPUT: 08:24:30 INFO - 2015-12-18 08:24:30,520 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58249/tests/kraken/driver.html?testName=imaging-darkroom) 08:24:31 INFO - 2015-12-18 08:24:31,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 161820672 08:24:31 INFO - 2015-12-18 08:24:31,093 DEBUG : BROWSER_OUTPUT: 08:24:34 INFO - 2015-12-18 08:24:34,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58249/tests/kraken/driver.html?testName=imaging-desaturate) 08:24:35 INFO - 2015-12-18 08:24:35,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 163573760 08:24:35 INFO - 2015-12-18 08:24:35,074 DEBUG : BROWSER_OUTPUT: 08:24:37 INFO - 2015-12-18 08:24:37,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58249/tests/kraken/driver.html?testName=json-parse-financial) 08:24:38 INFO - 2015-12-18 08:24:38,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 163004416 08:24:38 INFO - 2015-12-18 08:24:38,521 DEBUG : BROWSER_OUTPUT: 08:24:40 INFO - 2015-12-18 08:24:40,291 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:24:40 INFO - 2015-12-18 08:24:40,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 172167168 08:24:40 INFO - 2015-12-18 08:24:40,852 DEBUG : BROWSER_OUTPUT: 08:24:42 INFO - 2015-12-18 08:24:42,727 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58249/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:24:43 INFO - 2015-12-18 08:24:43,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 171507712 08:24:43 INFO - 2015-12-18 08:24:43,320 DEBUG : BROWSER_OUTPUT: 08:24:45 INFO - 2015-12-18 08:24:45,432 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:24:46 INFO - 2015-12-18 08:24:46,013 DEBUG : BROWSER_OUTPUT: RSS: Main: 182964224 08:24:46 INFO - 2015-12-18 08:24:46,013 DEBUG : BROWSER_OUTPUT: 08:24:48 INFO - 2015-12-18 08:24:48,534 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:24:49 INFO - 2015-12-18 08:24:49,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 190173184 08:24:49 INFO - 2015-12-18 08:24:49,121 DEBUG : BROWSER_OUTPUT: 08:24:51 INFO - 2015-12-18 08:24:51,695 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:24:52 INFO - 2015-12-18 08:24:52,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 187777024 08:24:52 INFO - 2015-12-18 08:24:52,263 DEBUG : BROWSER_OUTPUT: 08:24:54 INFO - 2015-12-18 08:24:54,020 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58249/tests/kraken/driver.html?testName=ai-astar) 08:24:54 INFO - 2015-12-18 08:24:54,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 246136832 08:24:54 INFO - 2015-12-18 08:24:54,279 DEBUG : BROWSER_OUTPUT: 08:24:54 INFO - 2015-12-18 08:24:54,279 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:24:54 INFO - 2015-12-18 08:24:54,279 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:24:54 INFO - 2015-12-18 08:24:54,279 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:24:54 INFO - 2015-12-18 08:24:54,279 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:24:54 INFO - 2015-12-18 08:24:54,279 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;113;104;110;111;111;101;110;113;102 08:24:54 INFO - 2015-12-18 08:24:54,280 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;130;151;168;129;161;153;142;175;129 08:24:54 INFO - 2015-12-18 08:24:54,280 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;161;162;164;162;160;163;161;164 08:24:54 INFO - 2015-12-18 08:24:54,280 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;72;82;92;72;71;72;96;94;73 08:24:54 INFO - 2015-12-18 08:24:54,280 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;129;94;95;94;142;94;95;130 08:24:54 INFO - 2015-12-18 08:24:54,280 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;110;109;110;110;110;109 08:24:54 INFO - 2015-12-18 08:24:54,280 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;146;147;146;148;146;146;146;147 08:24:54 INFO - 2015-12-18 08:24:54,280 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;94 08:24:54 INFO - 2015-12-18 08:24:54,280 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;74;72;72;73;74;73;82;70;72 08:24:54 INFO - 2015-12-18 08:24:54,281 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;67;68;68;68;67;68;68;69 08:24:54 INFO - 2015-12-18 08:24:54,281 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;84;85;85;84;84;83;84;83 08:24:54 INFO - 2015-12-18 08:24:54,281 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;131;127;122;132;134;121;119;120;124 08:24:54 INFO - 2015-12-18 08:24:54,281 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;160;144;147;145;133;143;147;146;133 08:24:54 INFO - 2015-12-18 08:24:54,281 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;70;69;74;68;67;68;67;69 08:24:54 INFO - 2015-12-18 08:24:54,281 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:24:54 INFO - 2015-12-18 08:24:54,281 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:24:54 INFO - 2015-12-18 08:24:54,282 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,957 08:24:54 INFO - 2015-12-18 08:24:54,282 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:24:54 INFO - 2015-12-18 08:24:54,282 DEBUG : BROWSER_OUTPUT: __startTimestamp1450455894273__endTimestamp 08:24:54 INFO - 2015-12-18 08:24:54,282 DEBUG : BROWSER_OUTPUT: 08:24:54 INFO - 2015-12-18 08:24:54,283 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:24:54 INFO - 2015-12-18 08:24:54,284 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:24:54 INFO - 2015-12-18 08:24:54,284 DEBUG : BROWSER_OUTPUT: 08:24:54 INFO - 2015-12-18 08:24:54,284 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.40 Median:110.50 stddev:4.43 (4.0%) stddev-sans-first:4.69 08:24:54 INFO - 2015-12-18 08:24:54,284 DEBUG : BROWSER_OUTPUT: Values: 109.0 113.0 104.0 110.0 111.0 111.0 101.0 110.0 113.0 102.0 08:24:54 INFO - 2015-12-18 08:24:54,284 DEBUG : BROWSER_OUTPUT: 08:24:54 INFO - 2015-12-18 08:24:54,285 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.30 Median:154.00 stddev:16.49 (10.7%) stddev-sans-first:17.36 08:24:54 INFO - 2015-12-18 08:24:54,285 DEBUG : BROWSER_OUTPUT: Values: 155.0 130.0 151.0 168.0 129.0 161.0 153.0 142.0 175.0 129.0 08:24:54 INFO - 2015-12-18 08:24:54,285 DEBUG : BROWSER_OUTPUT: 08:24:54 INFO - 2015-12-18 08:24:54,285 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.48 (0.9%) stddev-sans-first:1.41 08:24:54 INFO - 2015-12-18 08:24:54,285 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 161.0 162.0 164.0 162.0 160.0 163.0 161.0 164.0 08:24:54 INFO - 2015-12-18 08:24:54,285 DEBUG : BROWSER_OUTPUT: 08:24:54 INFO - 2015-12-18 08:24:54,285 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.90 Median:78.50 stddev:10.26 (13.1%) stddev-sans-first:10.73 08:24:54 INFO - 2015-12-18 08:24:54,285 DEBUG : BROWSER_OUTPUT: Values: 75.0 72.0 82.0 92.0 72.0 71.0 72.0 96.0 94.0 73.0 08:24:54 INFO - 2015-12-18 08:24:54,285 DEBUG : BROWSER_OUTPUT: 08:24:54 INFO - 2015-12-18 08:24:54,285 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.30 Median:94.50 stddev:19.20 (20.3%) stddev-sans-first:19.92 08:24:54 INFO - 2015-12-18 08:24:54,286 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 129.0 94.0 95.0 94.0 142.0 94.0 95.0 130.0 08:24:54 INFO - 2015-12-18 08:24:54,286 DEBUG : BROWSER_OUTPUT: 08:24:54 INFO - 2015-12-18 08:24:54,286 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:24:54 INFO - 2015-12-18 08:24:54,286 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 110.0 109.0 110.0 110.0 110.0 109.0 08:24:54 INFO - 2015-12-18 08:24:54,286 DEBUG : BROWSER_OUTPUT: 08:24:54 INFO - 2015-12-18 08:24:54,286 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.73 08:24:54 INFO - 2015-12-18 08:24:54,286 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 146.0 147.0 146.0 148.0 146.0 146.0 146.0 147.0 08:24:54 INFO - 2015-12-18 08:24:54,286 DEBUG : BROWSER_OUTPUT: 08:24:54 INFO - 2015-12-18 08:24:54,286 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 08:24:54 INFO - 2015-12-18 08:24:54,286 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 94.0 08:24:54 INFO - 2015-12-18 08:24:54,287 DEBUG : BROWSER_OUTPUT: 08:24:54 INFO - 2015-12-18 08:24:54,287 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.50 Median:73.00 stddev:3.21 (4.4%) stddev-sans-first:3.40 08:24:54 INFO - 2015-12-18 08:24:54,287 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 72.0 72.0 73.0 74.0 73.0 82.0 70.0 72.0 08:24:54 INFO - 2015-12-18 08:24:54,287 DEBUG : BROWSER_OUTPUT: 08:24:54 INFO - 2015-12-18 08:24:54,287 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 08:24:54 INFO - 2015-12-18 08:24:54,287 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 67.0 68.0 68.0 68.0 67.0 68.0 68.0 69.0 08:24:54 INFO - 2015-12-18 08:24:54,287 DEBUG : BROWSER_OUTPUT: 08:24:54 INFO - 2015-12-18 08:24:54,287 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:0.79 (0.9%) stddev-sans-first:0.78 08:24:54 INFO - 2015-12-18 08:24:54,287 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 84.0 85.0 85.0 84.0 84.0 83.0 84.0 83.0 08:24:54 INFO - 2015-12-18 08:24:54,287 DEBUG : BROWSER_OUTPUT: 08:24:54 INFO - 2015-12-18 08:24:54,288 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:125.50 stddev:5.60 (4.5%) stddev-sans-first:5.64 08:24:54 INFO - 2015-12-18 08:24:54,288 DEBUG : BROWSER_OUTPUT: Values: 120.0 131.0 127.0 122.0 132.0 134.0 121.0 119.0 120.0 124.0 08:24:54 INFO - 2015-12-18 08:24:54,288 DEBUG : BROWSER_OUTPUT: 08:24:54 INFO - 2015-12-18 08:24:54,288 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:145.50 stddev:8.27 (5.7%) stddev-sans-first:8.07 08:24:54 INFO - 2015-12-18 08:24:54,288 DEBUG : BROWSER_OUTPUT: Values: 134.0 160.0 144.0 147.0 145.0 133.0 143.0 147.0 146.0 133.0 08:24:54 INFO - 2015-12-18 08:24:54,288 DEBUG : BROWSER_OUTPUT: 08:24:54 INFO - 2015-12-18 08:24:54,288 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.50 stddev:2.04 (3.0%) stddev-sans-first:2.15 08:24:54 INFO - 2015-12-18 08:24:54,288 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 70.0 69.0 74.0 68.0 67.0 68.0 67.0 69.0 08:24:54 INFO - 2015-12-18 08:24:54,288 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:24:54 INFO - 2015-12-18 08:24:54,288 DEBUG : BROWSER_OUTPUT: 08:24:55 INFO - 2015-12-18 08:24:55,201 INFO : Browser exited with error code: 0 08:24:55 INFO - 2015-12-18 08:24:55,251 INFO : Completed test kraken (00:01:00) 08:24:55 INFO - 2015-12-18 08:24:55,251 INFO : Starting test v8_7 08:24:55 INFO - 2015-12-18 08:24:55,251 DEBUG : operating with platform_type : linux_ 08:24:55 INFO - 2015-12-18 08:24:55,251 INFO : Initialising browser for v8_7 test... 08:24:55 INFO - 2015-12-18 08:24:55,257 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0lcDjh/profile http://localhost:58249/getInfo.html 08:24:59 INFO - 2015-12-18 08:24:59,580 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:24:59 INFO - 2015-12-18 08:24:59,580 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:24:59 INFO - 2015-12-18 08:24:59,580 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:24:59 INFO - 2015-12-18 08:24:59,580 DEBUG : BROWSER_OUTPUT: __metrics 08:24:59 INFO - 2015-12-18 08:24:59,701 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] 08:24:59 INFO - 2015-12-18 08:24:59,777 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] 08:25:00 INFO - 2015-12-18 08:25:00,977 INFO : Browser initialized. 08:25:00 INFO - 2015-12-18 08:25:00,978 INFO : Running cycle 1/1 for v8_7 test... 08:25:00 INFO - 2015-12-18 08:25:00,978 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0lcDjh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:25:13 INFO - 2015-12-18 08:25:12,999 DEBUG : BROWSER_OUTPUT: RSS: Main: 150380544 08:25:13 INFO - 2015-12-18 08:25:12,999 DEBUG : BROWSER_OUTPUT: 08:25:34 INFO - 2015-12-18 08:25:34,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58249/tests/v8_7/run.html (next: http://localhost:58249/tests/v8_7/run.html) 08:25:34 INFO - 2015-12-18 08:25:34,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 450928640 08:25:34 INFO - 2015-12-18 08:25:34,641 DEBUG : BROWSER_OUTPUT: 08:25:34 INFO - 2015-12-18 08:25:34,641 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:25:34 INFO - 2015-12-18 08:25:34,642 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:25:34 INFO - 2015-12-18 08:25:34,642 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:25:34 INFO - 2015-12-18 08:25:34,642 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:25:34 INFO - 2015-12-18 08:25:34,642 DEBUG : BROWSER_OUTPUT: |0;Richards;167.33601070950468 08:25:34 INFO - 2015-12-18 08:25:34,642 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.25379770285292 08:25:34 INFO - 2015-12-18 08:25:34,642 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.8622420524261 08:25:34 INFO - 2015-12-18 08:25:34,642 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 08:25:34 INFO - 2015-12-18 08:25:34,642 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1994.0239043824702 08:25:34 INFO - 2015-12-18 08:25:34,642 DEBUG : BROWSER_OUTPUT: |5;Earley;779.423226812159 08:25:34 INFO - 2015-12-18 08:25:34,642 DEBUG : BROWSER_OUTPUT: |6;Boyer;12047.619047619048 08:25:34 INFO - 2015-12-18 08:25:34,642 DEBUG : BROWSER_OUTPUT: |7;RegExp;27243.243243243243 08:25:34 INFO - 2015-12-18 08:25:34,642 DEBUG : BROWSER_OUTPUT: |8;Splay;610.1281269066504 08:25:34 INFO - 2015-12-18 08:25:34,642 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 08:25:34 INFO - 2015-12-18 08:25:34,642 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:25:34 INFO - 2015-12-18 08:25:34,642 DEBUG : BROWSER_OUTPUT: __startTimestamp1450455934636__endTimestamp 08:25:34 INFO - 2015-12-18 08:25:34,642 DEBUG : BROWSER_OUTPUT: 08:25:34 INFO - 2015-12-18 08:25:34,643 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:25:34 INFO - 2015-12-18 08:25:34,643 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:25:34 INFO - 2015-12-18 08:25:34,643 DEBUG : BROWSER_OUTPUT: 08:25:34 INFO - 2015-12-18 08:25:34,643 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.34 Median:167.34 stddev:0.00 (0.0%) 08:25:34 INFO - 2015-12-18 08:25:34,643 DEBUG : BROWSER_OUTPUT: Values: 167.3 08:25:34 INFO - 2015-12-18 08:25:34,643 DEBUG : BROWSER_OUTPUT: 08:25:34 INFO - 2015-12-18 08:25:34,643 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.25 Median:185.25 stddev:0.00 (0.0%) 08:25:34 INFO - 2015-12-18 08:25:34,643 DEBUG : BROWSER_OUTPUT: Values: 185.3 08:25:34 INFO - 2015-12-18 08:25:34,643 DEBUG : BROWSER_OUTPUT: 08:25:34 INFO - 2015-12-18 08:25:34,643 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.86 Median:278.86 stddev:0.00 (0.0%) 08:25:34 INFO - 2015-12-18 08:25:34,643 DEBUG : BROWSER_OUTPUT: Values: 278.9 08:25:34 INFO - 2015-12-18 08:25:34,643 DEBUG : BROWSER_OUTPUT: 08:25:34 INFO - 2015-12-18 08:25:34,643 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 08:25:34 INFO - 2015-12-18 08:25:34,643 DEBUG : BROWSER_OUTPUT: Values: 5186.5 08:25:34 INFO - 2015-12-18 08:25:34,644 DEBUG : BROWSER_OUTPUT: 08:25:34 INFO - 2015-12-18 08:25:34,644 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1994.02 Median:1994.02 stddev:0.00 (0.0%) 08:25:34 INFO - 2015-12-18 08:25:34,644 DEBUG : BROWSER_OUTPUT: Values: 1994.0 08:25:34 INFO - 2015-12-18 08:25:34,644 DEBUG : BROWSER_OUTPUT: 08:25:34 INFO - 2015-12-18 08:25:34,644 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:779.42 Median:779.42 stddev:0.00 (0.0%) 08:25:34 INFO - 2015-12-18 08:25:34,644 DEBUG : BROWSER_OUTPUT: Values: 779.4 08:25:34 INFO - 2015-12-18 08:25:34,644 DEBUG : BROWSER_OUTPUT: 08:25:34 INFO - 2015-12-18 08:25:34,644 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12047.62 Median:12047.62 stddev:0.00 (0.0%) 08:25:34 INFO - 2015-12-18 08:25:34,644 DEBUG : BROWSER_OUTPUT: Values: 12047.6 08:25:34 INFO - 2015-12-18 08:25:34,644 DEBUG : BROWSER_OUTPUT: 08:25:34 INFO - 2015-12-18 08:25:34,644 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27243.24 Median:27243.24 stddev:0.00 (0.0%) 08:25:34 INFO - 2015-12-18 08:25:34,645 DEBUG : BROWSER_OUTPUT: Values: 27243.2 08:25:34 INFO - 2015-12-18 08:25:34,645 DEBUG : BROWSER_OUTPUT: 08:25:34 INFO - 2015-12-18 08:25:34,645 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:610.13 Median:610.13 stddev:0.00 (0.0%) 08:25:34 INFO - 2015-12-18 08:25:34,645 DEBUG : BROWSER_OUTPUT: Values: 610.1 08:25:34 INFO - 2015-12-18 08:25:34,645 DEBUG : BROWSER_OUTPUT: 08:25:34 INFO - 2015-12-18 08:25:34,645 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 08:25:34 INFO - 2015-12-18 08:25:34,645 DEBUG : BROWSER_OUTPUT: Values: 4826.9 08:25:34 INFO - 2015-12-18 08:25:34,645 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:25:34 INFO - 2015-12-18 08:25:34,645 DEBUG : BROWSER_OUTPUT: 08:25:35 INFO - 2015-12-18 08:25:35,545 INFO : Browser exited with error code: 0 08:25:35 INFO - 2015-12-18 08:25:35,560 INFO : Completed test v8_7 (00:00:40) 08:25:35 INFO - 2015-12-18 08:25:35,661 INFO : Completed test suite (00:20:18) 08:25:35 INFO - 2015-12-18 08:25:35,661 DEBUG : Working with test: dromaeo_css 08:25:35 INFO - 2015-12-18 08:25:35,661 DEBUG : Generating results file: dromaeo_css 08:25:35 INFO - 2015-12-18 08:25:35,662 DEBUG : Working with test: kraken 08:25:35 INFO - 2015-12-18 08:25:35,662 DEBUG : Generating results file: kraken 08:25:35 INFO - 2015-12-18 08:25:35,663 INFO : javascript benchmark 08:25:35 INFO - 2015-12-18 08:25:35,663 DEBUG : Working with test: v8_7 08:25:35 INFO - 2015-12-18 08:25:35,663 DEBUG : Generating results file: v8_7 08:25:35 INFO - 2015-12-18 08:25:35,663 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:25:35 INFO - 2015-12-18 08:25:35,723 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 08:25:35 INFO - 2015-12-18 08:25:35,723 DEBUG : process_Request line: dromaeo_css 6257.80 graph.html#tests=[[72,132,35]] 08:25:35 INFO - 2015-12-18 08:25:35,723 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:25:35 INFO - 2015-12-18 08:25:35,759 DEBUG : process_Request line: kraken 1518.90 graph.html#tests=[[232,132,35]] 08:25:35 INFO - 2015-12-18 08:25:35,759 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:25:35 INFO - 2015-12-18 08:25:35,899 DEBUG : process_Request line: v8_7 19797.27 graph.html#tests=[[230,132,35]] 08:25:35 INFO - 2015-12-18 08:25:35,900 INFO : javascript benchmark 08:25:35 INFO - 2015-12-18 08:25:35,904 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2633.789296856251, 2733.398652296494, 2739.5205838978172, 2746.2722378569683, 2748.203021123875, 4509.323601459782, 4610.608098311639, 4757.738324392157, 4818.975905120474, 4823.807047718087, 4613.400257966459, 4680.368150299709, 4731.266653668678, 4734.0, 4744.667873248874, 4363.629091527224, 4387.648988080946, 4410.095930334282, 4491.034427598082, 4512.481064677555, 4209.536950935395, 4415.20526305265, 4448.088141930913, 4500.459944806611, 4526.569975852305, 4242.575742425748, 4307.676924230664, 4403.823847046115, 4425.0, 4439.955600443986, 4358.0, 4358.782060896974, 4367.6023672424835, 4385.605295523418, 4414.073044660625, 4180.581941805825, 4354.934675979863, 4365.236083685342, 4404.779761011937, 4420.602145806861, 4610.2623580227, 4631.096936097462, 4697.154512187805, 4787.281907713871, 4837.9516204837855, 5142.562882155022, 5154.639175257734, 5155.149400348938, 5164.845054648366, 5199.66202196856, 4865.270209468608, 5174.741262936838, 5176.8964620707375, 5185.714785686786, 5186.1442861927735, 4690.202665546865, 4713.599344055725, 4713.9764301178275, 4829.13075646387, 4835.492273311252, 5326.147816349443, 5353.544948679328, 5395.4604539545735, 5399.541039011649, 5401.621886467988, 5080.212567052113, 5119.129747942859, 5121.4622464641425, 5123.103456895028, 5168.121419358718, 4850.442199147073, 4971.776270067856, 4972.0, 5189.532942035235, 5216.26972223889, 5004.84985450437, 5079.619028572872, 5110.156824124052, 5117.8720531986255, 5130.769115389817, 5007.84976450707, 5039.118154322979, 5043.243513472935, 5045.949540504622, 5048.066107770074, 4003.4395184674167, 4233.872983810491, 4234.576542345741, 4235.004773878136, 4280.315149576053, 3620.3845346291196, 3676.613955534684, 3682.760620559655, 3710.888673339804, 3718.0147260975864, 4366.716163449366, 4371.868843934687, 4397.362382454527, 4399.912001759947, 4434.578715022068, 4809.302651115639, 5131.820386286462, 5144.0, 5146.073706732824, 5147.124988751922, 4222.2611043067955, 4238.491381034296, 4320.373545835899, 4391.736495810262, 4415.602595766396, 4492.0791237796175, 4495.168393847149, 4496.887577810581, 4520.412346394947, 4530.61489773373, 4687.0, 4774.259989701602, 4783.856484305476, 4785.641076919175, 4839.395075615548, 4920.45874953762, 4921.97539012317, 5005.324281221989, 5083.237514372726, 5130.153524668388, 4732.219183834766, 4762.071396077731, 4764.0, 4805.471398146271, 4806.2310030394965, 4749.430068391815, 4978.5270399312, 4987.301777751045, 4987.516228902485, 5033.672811267403, 4951.72765497901, 4972.602191824718, 5118.053160165381, 5181.248718935658, 5213.869653258699, 4969.925451118308, 4988.102141614544, 4990.900181996412, 4992.2761199626575, 5033.798648054037, 4640.466346370211, 4962.255661650637, 4965.8013679452415, 4980.302757613865, 4980.601551875914, 4727.17274476972, 4733.053389322218, 4839.104765618372, 4918.311436398979, 4940.629452790983, 5049.924251136309, 5056.064628043824, 5058.570021548209, 5061.9493805061475, 5064.063148317573, 4658.0, 4929.2359684248995, 4935.629827763004, 4944.381952255968, 4998.750062496933], "unit": "score", "name": "dojo.html", "value": 4663.080523764438}, {"lowerIsBetter": false, "replicates": [568.8606291458595, 570.3925319534695, 575.9913601295979, 576.0753989846297, 578.9565782566307, 24308.87845560772, 32935.17662058447, 33699.83150084252, 33724.83137584315, 33766.83116584414, 37988.43017354742, 38427.807860960726, 38544.0, 38565.0, 38589.614103858956, 6849.212340580847, 6948.235694073673, 7688.308052275294, 7911.485753426037, 7936.44444888858, 9909.603615855358, 10238.385696858175, 10238.488075596228, 10246.333988290737, 10252.794944101113, 9779.853302200472, 9921.90078099217, 9926.0, 9927.851082233736, 9927.900720992806, 7091.822704432405, 7270.963645181793, 9793.55928983194, 9934.80130397388, 10281.588736450607, 9760.4631745254, 9920.603175872957, 9926.106650401498, 9926.652567160114, 9928.404295742206, 35331.0, 35711.82144089289, 35841.0, 35846.0, 35862.64137358619, 2943.440746258204, 2949.970500294991, 2999.2351950252546, 3118.8284644344553, 3339.2820543583002, 27496.0, 27578.44843103147, 27712.445751084866, 27939.86030069857, 27991.440171196464, 3410.4543273076188, 3419.64093770153, 3465.1163953192026, 3483.3033393321184, 3519.595246546629, 212012.0, 213492.0, 213518.0, 214649.9267503668, 214781.0, 48727.512724873006, 50444.24333634999, 50791.0, 50845.0, 50861.0, 42823.571764282584, 59685.70157149187, 61657.0, 61680.07479887805, 61682.38317616856, 13468.93265533666, 13657.0, 13689.178649281075, 13697.726045479034, 13698.726025479435, 10968.725781855357, 11050.392228427352, 11067.446627668583, 11077.72305692348, 11079.50142243601, 17046.403375881786, 17225.1387430628, 17240.568985775455, 17258.482245532403, 17264.568385790204, 7224.783256502314, 7337.321877514775, 7445.798306728159, 7462.403007759366, 7521.5111017783665, 821.4988856797349, 829.2246749289434, 836.7782537627412, 893.6246776353947, 896.4307664633005, 25561.0, 27136.864315678296, 28632.284192894927, 29051.273718157216, 29067.0, 1012.9493525323704, 1024.364893765855, 1037.870266216723, 1063.9466927741635, 1068.6740544133959, 12852.678683032813, 12934.59133253132, 12950.740985180244, 12956.80564791529, 13032.0, 248552.0, 250136.0, 251265.0, 252495.0, 252655.0, 42063.78968105201, 42326.0, 42347.57652423436, 42366.36450453246, 42376.36435453471, 1193.2899924544881, 1229.846269216348, 1236.394166858233, 1241.472374240944, 1246.856611489672, 23859.403514912265, 24512.632310515, 24689.753102468745, 24826.255212343658, 24938.62592061084, 37235.627643723215, 37519.81240093782, 37549.81225093857, 37585.81207093947, 37654.2469150621, 224135.0, 241228.0, 243403.0, 243602.0, 243691.0, 23244.418889527897, 26731.599026014235, 27364.179074627795, 27518.0, 27750.0, 31049.534256986615, 31157.688423116386, 31459.213519662193, 31751.936124151856, 31813.04560863085, 27234.72765272322, 27422.45155096847, 27670.5849412263, 27676.308092297855, 28046.0, 25739.613905791055, 26845.194644160707, 31600.367992640477, 31621.36757264796, 32033.359332813678, 28237.858810706635, 28434.85782571074, 28767.568486473137, 30477.08568742941, 30518.694813051585, 25953.7023148838, 26903.86548067247, 27122.0, 27295.317617059733, 27448.0, 21568.137274508845, 21704.67442988325, 21988.89005554962, 22073.117075316808, 22126.0], "unit": "score", "name": "ext.html", "value": 16468.71968675824}, {"lowerIsBetter": false, "replicates": [311.73813996243166, 315.71743289755653, 319.5446488753527, 321.48080849428175, 322.8321272938072, 11969.0, 12379.504819807196, 14751.77872331916, 15142.621434464143, 15469.45856895009, 14294.71410571788, 14358.784618230735, 14564.563063108124, 14598.416063357454, 14627.780583291233, 4414.933775993362, 4677.976610116944, 4695.530446955311, 4827.493113223114, 4890.853274401756, 4844.709317440947, 4893.4617192108835, 4895.534924182215, 4897.191963326047, 4899.8040078397, 4736.2895565665085, 4831.492693267209, 4847.75761211938, 4866.270059491087, 4892.5596696297325, 4790.23356262998, 4838.322634831109, 4839.564439200453, 4841.515848415148, 4843.636727245435, 4279.122779830159, 4300.892477688051, 4302.677299202541, 4316.201502722007, 4321.027768752006, 17889.0, 18252.45242642723, 18413.171407286703, 18622.813771862242, 19323.227070917146, 1662.7588999595112, 1732.6274850907116, 1922.3464022232367, 1945.3191383015974, 1965.2335589120255, 8456.365772567082, 8566.914330856674, 8740.388172827905, 10989.560417583287, 11587.652370428901, 1702.8467437930647, 1711.1853088480807, 1762.215813962787, 1767.08994867642, 1833.5966087460738, 52377.2143417849, 54566.0, 54644.0, 54893.9999999996, 55898.16152757712, 9285.860712089325, 9302.488363140092, 9349.036702292595, 9389.873215214082, 9394.577244024036, 10500.0, 10814.729631759268, 11794.941025294818, 11813.054955603531, 12001.63995080149, 6385.201849768779, 6520.869582608416, 6700.396964273239, 6723.966380168165, 6825.044493770876, 6365.2998170201245, 6385.48916086712, 6497.577657452345, 6509.674516274167, 6552.180977377828, 4008.038070862972, 4053.4751900222077, 4084.9795751021056, 4113.465249517543, 4114.382842573638, 1664.4923298393865, 1700.8554272886695, 1718.0328523840133, 1725.6462425202803, 1731.9945357915633, 829.7718127514861, 846.5851732650957, 904.5341649050744, 908.9681861134961, 956.4930586789013, 14554.981151319305, 15013.0, 15846.603834903988, 16607.169641517874, 16951.491455256117, 759.9924000759921, 850.6852464588142, 894.552723638181, 958.2956526952685, 994.105305225303, 8022.077461092049, 8833.55832208387, 9326.860097098548, 9331.766705832408, 9490.145886870216, 480480.0, 493364.0, 497847.0, 498086.0, 501430.0, 52019.47980520222, 59784.103238451455, 60178.39821601728, 70920.29079709137, 72197.63901180566, 1046.853440518328, 1061.0927656853435, 1071.5499490214129, 1071.8660167479065, 1072.822984207597, 13392.589333919988, 13599.116057456235, 14035.438582456587, 14130.717385652435, 14142.575722728334, 29849.5522567166, 31962.20094497563, 32822.343553128325, 32885.83557082295, 33133.502997454576, 39113.41329879997, 39187.020324492114, 39355.60644393634, 42514.0, 45113.77443112763, 13226.537071202461, 13435.193888366339, 13477.0, 13500.054996150175, 14392.0, 17458.47624571265, 17788.55528611795, 18101.637967240316, 18190.81809181944, 18266.817331827042, 14443.85556144425, 14818.40726370933, 15112.773308400163, 15234.0, 15265.6183595411, 14340.924430667534, 14431.711365772835, 14532.709345813237, 14862.108273503625, 15084.622884427978, 14218.502352417616, 14246.145231286157, 14619.12285262845, 14718.116912985255, 15010.624734381729, 13520.932395338354, 13559.322033898068, 13731.382087805872, 13751.243681597609, 13822.37799299014, 14053.648658783612, 14365.569032929028, 14631.487897923522, 14776.926115369784, 14929.776053359426], "unit": "score", "name": "jquery.html", "value": 8361.045971904761}, {"lowerIsBetter": false, "replicates": [1416.1220043572987, 1639.5327331710464, 1654.7517872319152, 1693.2211182855885, 1718.5617667494787, 5834.124881267807, 6814.863702725948, 6940.895886561706, 6992.8601427971535, 7010.6845191966295, 6858.828529286758, 6982.546134501266, 6985.336393042666, 6989.056477375553, 7000.684969176386, 2053.4660988143114, 2088.937331880046, 2090.5087304483436, 2091.801278878504, 2092.790720927903, 2099.9685004724943, 2106.610277098734, 2121.459027947879, 2130.3289463818924, 2142.2823354176294, 2029.3810387831707, 2035.9592808143827, 2063.1850419084453, 2064.9896750516227, 2065.215218217083, 2085.708000879878, 2112.271266413085, 2114.164904862586, 2117.4388786971463, 2117.7035215069827, 2066.2045112631595, 2090.2997495838913, 2101.5796840631933, 2103.4741314671332, 2107.599556084339, 7138.179109402433, 7224.349808517206, 7224.7110115595315, 7239.348458638695, 7244.058272424604, 4183.728057676241, 4257.680673949466, 4271.487421509408, 4291.399204111427, 4299.398084268205, 2737.072301247716, 2758.586212068186, 2790.8185967912023, 2814.802963792535, 2824.7175282471794, 860.9526476043815, 1683.3266693322646, 1726.0161707826544, 1767.0899486764326, 1772.521419216817, 9670.274729395323, 9769.267304952156, 9796.069373409586, 9815.214782817358, 9825.115739583473, 3752.2683076799763, 3752.45589389537, 3809.4095415210686, 3810.2760475510117, 3925.2345792570177, 7948.960255198687, 7961.004874390701, 7961.1242763295995, 7963.800904977422, 7982.481138725964, 4271.530131685512, 4288.957110428856, 4291.957080429218, 4294.033842385501, 4299.312110062375, 3255.0723043932367, 3357.093584732109, 3801.6008319126095, 3961.6830653547645, 3964.900877478086, 3273.0998975281514, 3273.672632736755, 3273.852676629557, 3302.7688061835443, 3347.1966727985596, 992.3500107429501, 1013.3058854684565, 1014.123870838942, 1028.3675539543126, 1031.3811712972156, 1137.3460260350332, 1137.374444055766, 1143.2911594811271, 1161.9825702614467, 1163.168334640736, 6853.211880633691, 6867.0, 6876.381125698711, 6892.931070689229, 6901.275366086589, 414.8071146916698, 422.2757970081264, 423.0903557351657, 427.76045414567943, 428.1501220078142, 5333.6266461348105, 5377.838664840061, 5383.273258110184, 5390.191471279261, 5397.78408863641, 7390.778276651601, 7394.408447324201, 7481.8877716834295, 8577.571121443903, 8745.256653184551, 8259.752207433787, 8445.915540844635, 8507.53208573522, 8520.488770673655, 8525.57372131391, 6721.428678562279, 6789.355011273921, 6837.9316206839285, 6889.655517224119, 6912.965435172792, 6820.488463365366, 6864.553804002724, 6865.931340686529, 6874.243833178246, 6896.517243792886, 7365.705371785283, 7678.232176782277, 7679.846403072019, 7691.30778229962, 7862.72480463181, 7784.84430311402, 7834.334081603128, 7967.203279671987, 8113.594320283844, 8122.1065682776025, 5284.497972692588, 5893.557983151367, 6346.968265158829, 6390.7443702251385, 6405.93594064072, 6690.13028306317, 6729.865402692017, 6785.626790526569, 6834.453243740588, 6848.7260509579055, 6266.404691554295, 6284.340144284967, 6527.15147030883, 6548.8362790930605, 6637.336266373324, 6082.72627731762, 6453.483721302378, 6453.677316134268, 6476.352364763486, 6576.243731970693, 6512.869742605027, 6553.803385898431, 6557.180352455943, 6558.639274839929, 6572.671366431755, 5330.866728331823, 5346.732663366738, 5348.839534813962, 5351.438098999549, 5371.919421208607, 6180.258368995749, 6199.969000154971, 6210.068489726577, 6215.81352559424, 6222.408871157233], "unit": "score", "name": "mootools.html", "value": 4060.476317836786}, {"lowerIsBetter": false, "replicates": [298.2781668362562, 303.47801780936794, 305.39836522051576, 306.1092221635041, 306.9907902762917, 5306.92039619406, 5322.760475778589, 5327.307450031495, 5330.546903513201, 5348.171033489805, 5242.7640756165965, 5249.632525723201, 5259.8422047338645, 5265.973670131644, 5273.288106105674, 3926.803659817012, 4141.068259641586, 4143.979280103596, 4147.605977432139, 4151.045259590296, 4026.8187931543002, 4056.9188616227657, 4104.610062044101, 4133.3386658134705, 4149.298787497127, 4075.5924407559155, 4092.1406504634065, 4099.036726369316, 4103.240900433414, 4104.220198162355, 3853.1523064925673, 3958.0698535844053, 3975.4434379186937, 4106.8562600309, 4115.711900166974, 3614.9096272593397, 3622.855085796565, 3626.746127771057, 3632.727545434103, 3636.672699457035, 5095.031943930679, 5101.081805275049, 5106.617003724736, 5120.411152717448, 5129.256257842592, 4720.858374248778, 4733.881652958669, 4738.526147385269, 4739.502352252998, 4739.857804265843, 5432.75552600134, 5557.972210138963, 5570.693611851347, 5571.749271282802, 5586.106223004341, 3966.3852102924093, 3976.7812770297624, 3978.1645854370618, 3978.9602103978877, 3983.0, 5861.17943487912, 5864.970675146597, 5865.208196893407, 5868.530517558585, 5872.853178670524, 4072.063425412172, 4085.6935729820384, 4086.4483294755423, 4091.57038510958, 4102.056526998747, 4043.959560404417, 4144.5233798113, 4157.625813676784, 4160.916781664349, 4175.54069052404, 4720.95279047212, 4733.195356789354, 4736.668433209642, 4739.95260047402, 4740.146773580788, 5565.471280228372, 5578.135389014709, 5578.525825304813, 5580.804671836466, 5583.3858275589655, 1426.5506365494837, 1437.4393986345333, 1437.6837095838898, 1438.173050495969, 1438.180237264749, 992.1120597065586, 994.28908330544, 996.2478328861663, 996.7009897030862, 1016.5323950982483, 4895.265710143507, 4903.656744027955, 4906.803727850846, 4914.041761856475, 4915.3855768029, 5777.30672319316, 5783.566232532577, 5784.045632470596, 5784.855378615484, 5787.8553036174435, 4901.950980490221, 4902.779374928136, 4905.288733133676, 4908.533689299511, 4909.5090490950615, 3040.3159289160203, 3081.337512434837, 3112.25305926576, 3117.7505799535984, 3120.1731541141617, 5447.264619276426, 5492.203630473638, 5504.366997795225, 5505.0, 5506.311711036121, 6003.159557661931, 6015.278166619946, 6022.247219097613, 6022.638641681513, 6024.096385542116, 5493.23094766733, 5503.724813759296, 5507.063799154073, 5507.421720719267, 5512.2558454608115, 5674.460926212003, 5825.097109947965, 5830.737616807169, 5840.386759390203, 5841.649501029951, 5667.461591148999, 5671.979043771996, 5695.971520142372, 5700.572457065654, 5703.315602127771, 5484.533814625802, 5488.945110549003, 5496.065668836387, 5499.312585926759, 5500.724963751876, 3881.4954055972544, 3930.6265904739003, 3970.3448930926074, 3975.741576797499, 3991.261616600938, 5822.126680997715, 5822.98097832886, 5826.563007774519, 5828.825135245949, 5831.300243970751, 5580.5535557156145, 5619.775208991595, 5622.522085622768, 5624.550035997192, 5629.408912064175, 5574.637648552831, 5611.130274807411, 5611.298587676541, 5615.691136987505, 5630.943690563042, 5350.705711185922, 5488.204210389551, 5493.066178749542, 5500.092484739973, 5503.587230957774, 5436.429174936733, 5575.135853942646, 5641.041023026013, 5656.321241451053, 5658.151277308437, 5394.703291319015, 5506.476884695948, 5541.0, 5544.279243698294, 5545.445455454423], "unit": "score", "name": "prototype.html", "value": 4209.375115282402}, {"lowerIsBetter": false, "replicates": [560.6075746977115, 619.5941658213872, 631.5452873930769, 663.5521023309267, 664.2759392262436, 10190.184785217183, 10267.127294180003, 10389.844152337702, 10405.11556517697, 10448.477576121191, 10761.946190269056, 11424.771504569904, 11483.138764592648, 11490.482928268228, 11510.482028308725, 626.3642402960999, 633.7116611941556, 774.8372841703249, 780.3406121827076, 800.3437181511134, 771.4946709905021, 781.5467029123095, 785.6621652689341, 786.2491320788633, 787.2009909941414, 642.299893116503, 828.7099515169702, 835.5028757889077, 835.6197929941862, 835.9122292159327, 647.9481641468672, 798.1220657277007, 810.8986376702912, 811.663159788687, 812.0904586862752, 605.6396444115744, 606.3178923710825, 606.336062012096, 606.4935778624854, 606.6996836565884, 11034.062104721108, 11035.117190624731, 11045.779084418267, 11050.723731906766, 11062.889371106266, 10571.682849514527, 11328.886711132865, 11352.772944541146, 11695.590654327058, 11754.118441116865, 8784.388613713687, 8942.0, 9076.63693452261, 9182.954085229598, 9223.07769223079, 3225.6290526589273, 3236.579244698174, 3267.068885367659, 3271.9018429446915, 3285.96714032859, 37013.074673133386, 37291.0, 37411.0, 37477.81261093704, 37755.0, 8714.9977752558, 8930.86603700945, 8981.0, 9002.279817614706, 9020.503872286956, 16037.599060023593, 16112.516624501284, 16118.0, 16128.435504757277, 16140.273687684083, 6090.573659843769, 6160.845978850564, 6277.811665650038, 6310.495160387158, 6348.269948955837, 3495.8426870790877, 3592.604813470516, 3603.135247540624, 3614.7469677122876, 3654.835532401048, 2507.8620675863003, 2550.4516528946365, 2553.527597394488, 2561.0, 2579.6775403074616, 452.2334642780521, 458.38347422716396, 471.74997251456784, 472.5321931288069, 478.2778005212085, 463.1616773639723, 470.2217829492196, 546.546366515791, 552.199310999053, 596.8239369386041, 7358.96320518394, 7391.445641576904, 7412.740554080581, 7635.809104772314, 7645.961770191114, 547.2038184441628, 565.8076254073635, 570.6519023395808, 571.3943220186616, 574.6552068758712, 3395.813230272359, 3553.964460355415, 3609.314230296235, 3860.4788353571907, 3997.6801855851463, 45292.54707452883, 47240.291395629094, 47242.52757472381, 47362.289565656545, 47438.28842567364, 41344.0, 41762.0, 42279.788601056796, 42617.57382426136, 43057.784711076245, 38080.38583606936, 38600.80699596484, 38924.416133758015, 39431.80284098619, 40178.799106004284, 7846.882296765667, 7947.205279472007, 7955.880661790194, 8159.102498725254, 8175.182481751777, 27858.303542411602, 28342.291442714097, 28694.282642934093, 28810.567841481974, 29876.103716888527, 33594.160145996546, 33692.49461258132, 34090.488642670876, 36060.27879442449, 36187.0, 9482.478463684563, 10056.89943100589, 10097.44464054484, 10217.182625389802, 10502.894971050191, 10992.477675117452, 11058.944705276745, 11152.665420037412, 11156.721081973015, 11343.773124537629, 10284.331518451278, 10420.218483613608, 10420.531076101443, 10471.476426178508, 10908.454577270946, 9481.620735170516, 9792.706218813448, 10010.399376037461, 10110.49447527606, 10222.13111885498, 10166.898331016891, 10679.733006674895, 10761.623343182951, 10785.083267922315, 10880.401577913291, 8256.422050456411, 8350.83298334042, 8548.444351117158, 8571.914280857112, 8906.287497000354, 7695.576743279174, 8201.753947381589, 8383.538905360263, 8555.272801811916, 8645.654173832976], "unit": "score", "name": "yui.html", "value": 5471.398968961561}], "name": "dromaeo_css", "value": 6257.801975942073}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 113.0, 104.0, 110.0, 111.0, 111.0, 101.0, 110.0, 113.0, 102.0], "unit": "score", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [155.0, 130.0, 151.0, 168.0, 129.0, 161.0, 153.0, 142.0, 175.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 149.3}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 162.0, 164.0, 162.0, 160.0, 163.0, 161.0, 164.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 82.0, 92.0, 72.0, 71.0, 72.0, 96.0, 94.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 129.0, 94.0, 95.0, 94.0, 142.0, 94.0, 95.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 106.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 146.0, 147.0, 146.0, 148.0, 146.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0], "unit": "score", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 72.0, 72.0, 73.0, 74.0, 73.0, 82.0, 70.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 73.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 85.0, 85.0, 84.0, 84.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [120.0, 131.0, 127.0, 122.0, 132.0, 134.0, 121.0, 119.0, 120.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [134.0, 160.0, 144.0, 147.0, 145.0, 133.0, 143.0, 147.0, 146.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 70.0, 69.0, 74.0, 68.0, 67.0, 68.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1518.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.33601070950468], "unit": "score", "name": "Richards", "value": 210.96475200000003}, {"lowerIsBetter": false, "replicates": [185.25379770285292], "unit": "score", "name": "DeltaBlue", "value": 356.90496399999995}, {"lowerIsBetter": false, "replicates": [278.8622420524261], "unit": "score", "name": "Encrypt", "value": 954.525066}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1994.0239043824702], "unit": "score", "name": "RayTrace", "value": 371.1033746253746}, {"lowerIsBetter": false, "replicates": [779.423226812159], "unit": "score", "name": "Earley", "value": 855.072029}, {"lowerIsBetter": false, "replicates": [12047.619047619048], "unit": "score", "name": "Boyer", "value": 55.31906324110671}, {"lowerIsBetter": false, "replicates": [27243.243243243243], "unit": "score", "name": "RegExp", "value": 33.43893353174606}, {"lowerIsBetter": false, "replicates": [610.1281269066504], "unit": "score", "name": "Splay", "value": 133.56374900000003}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19797.27265212226}]} 08:25:35 INFO - RETURN: dromaeo_css: 6257.80 08:25:35 INFO - RETURN: kraken: 1518.90 08:25:35 INFO - RETURN: v8_7: 19797.27 08:25:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19797.27"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1518.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6257.80"}}} 08:25:36 INFO - Return code: 0 08:25:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:25:36 INFO - # TBPL SUCCESS # 08:25:36 INFO - Running post-action listener: _resource_record_post_action 08:25:36 INFO - Running post-run listener: _resource_record_post_run 08:25:37 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 8192; Write bytes: 561733632; Read time: 244; Write time: 793824 08:25:37 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 244162560; Read time: 0; Write time: 492672 08:25:37 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 8192; Write bytes: 317571072; Read time: 244; Write time: 301152 08:25:37 INFO - Running post-run listener: _upload_blobber_files 08:25:37 INFO - Blob upload gear active. 08:25:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:25:37 INFO - Copying logs to upload dir... 08:25:37 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.734581 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-18 08:25:37.011940) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 08:25:37.015786) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/MCH_plYIRxik3spqFvPrqw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010000 build_url: 'https://queue.taskcluster.net/v1/task/MCH_plYIRxik3spqFvPrqw/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-18 08:25:37.068734) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 08:25:37.069212) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450454549.575148-1734258410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 08:25:37.120991) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 08:25:37.121487) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 08:25:37.121880) ========= ========= Total master_lag: 0.26 =========