builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-027 starttime: 1450443416.44 results: success (0) buildid: 20151218042953 builduid: fe65a86d524a4320b2008e15c4b2750a revision: ff3fcdae5d51b69077bf1d410350c2fc6b2131e0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 04:56:56.440299) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 04:56:56.440739) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 04:56:56.441033) ========= 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=447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004304 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 04:56:56.458407) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 04:56:56.458765) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 04:56:56.472364) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 04:56:56.472741) ========= 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=447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 04:56:56.522092) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 04:56:56.522426) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 04:56:56.522837) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 04:56:56.523135) ========= 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=447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 04:56:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 32.3M=0s 2015-12-18 04:56:56 (32.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.195343 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 04:56:56.731193) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 04:56:56.731558) ========= 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=447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018588 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 04:56:56.782428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 04:56:56.782863) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ff3fcdae5d51b69077bf1d410350c2fc6b2131e0 --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 ff3fcdae5d51b69077bf1d410350c2fc6b2131e0 --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=447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 04:56:56,950 truncating revision to first 12 chars 2015-12-18 04:56:56,950 Setting DEBUG logging. 2015-12-18 04:56:56,950 attempt 1/10 2015-12-18 04:56:56,950 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ff3fcdae5d51?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 04:56:57,616 unpacking tar archive at: fx-team-ff3fcdae5d51/testing/mozharness/ program finished with exit code 0 elapsedTime=0.922098 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 04:56:57.718115) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 04:56:57.718430) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 04:56:57.728524) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 04:56:57.728921) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 04:56:57.729375) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-18 04:56:57.729655) ========= /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=447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:56:57 INFO - MultiFileLogger online at 20151218 04:56:57 in /builds/slave/test 04:56:57 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 04:56:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:56:57 INFO - {'append_to_log': False, 04:56:57 INFO - 'base_work_dir': '/builds/slave/test', 04:56:57 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:56:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:56:57 INFO - 'branch': 'Fx-Team-Non-PGO', 04:56:57 INFO - 'buildbot_json_path': 'buildprops.json', 04:56:57 INFO - 'config_files': ('talos/linux_config.py',), 04:56:57 INFO - 'default_actions': ('clobber', 04:56:57 INFO - 'read-buildbot-config', 04:56:57 INFO - 'download-and-extract', 04:56:57 INFO - 'populate-webroot', 04:56:57 INFO - 'create-virtualenv', 04:56:57 INFO - 'install', 04:56:57 INFO - 'run-tests'), 04:56:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:56:57 INFO - 'download_minidump_stackwalk': True, 04:56:57 INFO - 'download_symbols': 'ondemand', 04:56:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:56:57 INFO - 'tooltool.py': '/tools/tooltool.py', 04:56:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:56:57 INFO - '/tools/misc-python/virtualenv.py')}, 04:56:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:56:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:56:57 INFO - 'installer_path': 'installer.exe', 04:56:57 INFO - 'log_level': 'info', 04:56:57 INFO - 'log_name': 'talos', 04:56:57 INFO - 'log_to_console': True, 04:56:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:56:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:56:57 INFO - 'opt_config_files': (), 04:56:57 INFO - 'pip_index': False, 04:56:57 INFO - 'sps_profile': False, 04:56:57 INFO - 'sps_profile_interval': 0, 04:56:57 INFO - 'suite': 'dromaeojs', 04:56:57 INFO - 'system_bits': '64', 04:56:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:56:57 INFO - 'title': 'talos-linux64-ix-027', 04:56:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:56:57 INFO - 'use_talos_json': True, 04:56:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:56:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:56:57 INFO - 'work_dir': 'build'} 04:56:57 INFO - ##### 04:56:57 INFO - ##### Running clobber step. 04:56:57 INFO - ##### 04:56:57 INFO - Running pre-action listener: _resource_record_pre_action 04:56:57 INFO - Running main action method: clobber 04:56:57 INFO - rmtree: /builds/slave/test/build 04:56:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:56:58 INFO - Running post-action listener: _resource_record_post_action 04:56:58 INFO - ##### 04:56:58 INFO - ##### Running read-buildbot-config step. 04:56:58 INFO - ##### 04:56:58 INFO - Running pre-action listener: _resource_record_pre_action 04:56:58 INFO - Running main action method: read_buildbot_config 04:56:58 INFO - Using buildbot properties: 04:56:58 INFO - { 04:56:58 INFO - "project": "", 04:56:58 INFO - "product": "firefox", 04:56:58 INFO - "script_repo_revision": "production", 04:56:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:56:58 INFO - "repository": "", 04:56:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:56:58 INFO - "buildid": "20151218042953", 04:56:58 INFO - "pgo_build": "False", 04:56:58 INFO - "basedir": "/builds/slave/test", 04:56:58 INFO - "buildnumber": 2231, 04:56:58 INFO - "slavename": "talos-linux64-ix-027", 04:56:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:56:58 INFO - "platform": "ubuntu64_hw", 04:56:58 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:56:58 INFO - "branch": "fx-team", 04:56:58 INFO - "repo_path": "integration/fx-team", 04:56:58 INFO - "revision": "ff3fcdae5d51b69077bf1d410350c2fc6b2131e0", 04:56:58 INFO - "stage_platform": "linux64", 04:56:58 INFO - "builduid": "fe65a86d524a4320b2008e15c4b2750a", 04:56:58 INFO - "slavebuilddir": "test" 04:56:58 INFO - } 04:56:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:56:58 INFO - Running post-action listener: _resource_record_post_action 04:56:58 INFO - ##### 04:56:58 INFO - ##### Running download-and-extract step. 04:56:58 INFO - ##### 04:56:58 INFO - Running pre-action listener: _resource_record_pre_action 04:56:58 INFO - Running main action method: download_and_extract 04:56:58 INFO - mkdir: /builds/slave/test/build/tests 04:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:58 INFO - https://queue.taskcluster.net/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:56:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/test_packages.json 04:56:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/test_packages.json 04:56:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:56:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:56:58 INFO - Downloaded 1302 bytes. 04:56:59 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:56:59 INFO - Using the following test package requirements: 04:56:59 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:56:59 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:56:59 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:59 INFO - u'jsshell-linux-x86_64.zip'], 04:56:59 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:56:59 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:56:59 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:56:59 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:56:59 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:56:59 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:56:59 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:56:59 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:59 INFO - https://queue.taskcluster.net/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:56:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:56:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:56:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/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 04:56:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/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 04:56:59 INFO - Downloaded 21870954 bytes. 04:56:59 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 04:56:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:56:59 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 04:57:00 INFO - Return code: 0 04:57:00 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 04:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:00 INFO - https://queue.taskcluster.net/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:57:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:57:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:57:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/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 04:57:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/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 04:57:01 INFO - Downloaded 21870954 bytes. 04:57:01 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 04:57:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:57:01 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 04:57:03 INFO - Return code: 0 04:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:03 INFO - https://queue.taskcluster.net/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:57:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:57:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:57:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/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 04:57:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/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 04:57:04 INFO - Downloaded 11132039 bytes. 04:57:04 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 04:57:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:57:04 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 04:57:04 INFO - Return code: 0 04:57:04 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')]} 04:57:04 INFO - https://queue.taskcluster.net/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:57:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/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 04:57:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/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 04:57:05 INFO - Downloaded 53015886 bytes. 04:57:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:05 INFO - mkdir: /builds/slave/test/properties 04:57:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:57:05 INFO - Writing to file /builds/slave/test/properties/build_url 04:57:05 INFO - Contents: 04:57:05 INFO - build_url:https://queue.taskcluster.net/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:05 INFO - Running post-action listener: _resource_record_post_action 04:57:05 INFO - Running post-action listener: set_extra_try_arguments 04:57:05 INFO - ##### 04:57:05 INFO - ##### Running populate-webroot step. 04:57:05 INFO - ##### 04:57:05 INFO - Running pre-action listener: _resource_record_pre_action 04:57:05 INFO - Running main action method: populate_webroot 04:57:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:57:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:57:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:57:05 INFO - '--tppagecycles', 04:57:05 INFO - '7'], 04:57:05 INFO - 'tests': ['tsvgm']}}, 04:57:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:57:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:57:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:57:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:57:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:57:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:57:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:05 INFO - 'talos_options': ['--e10s'], 04:57:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:05 INFO - 'tests': ['damp', 'tps']}, 04:57:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:05 INFO - 'talos_options': ['--e10s'], 04:57:05 INFO - 'tests': ['damp', 'tps']}, 04:57:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:57:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:57:05 INFO - 'other': {'tests': ['a11yr', 04:57:05 INFO - 'ts_paint', 04:57:05 INFO - 'tpaint', 04:57:05 INFO - 'sessionrestore', 04:57:05 INFO - 'sessionrestore_no_auto_restore']}, 04:57:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:57:05 INFO - 'tests': ['a11yr', 04:57:05 INFO - 'ts_paint', 04:57:05 INFO - 'tpaint', 04:57:05 INFO - 'sessionrestore', 04:57:05 INFO - 'sessionrestore_no_auto_restore']}, 04:57:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:57:05 INFO - 'tests': ['a11yr', 04:57:05 INFO - 'ts_paint', 04:57:05 INFO - 'tpaint', 04:57:05 INFO - 'sessionrestore', 04:57:05 INFO - 'sessionrestore_no_auto_restore']}, 04:57:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:57:05 INFO - 'tests': ['a11yr', 04:57:05 INFO - 'ts_paint', 04:57:05 INFO - 'tpaint', 04:57:05 INFO - 'sessionrestore', 04:57:05 INFO - 'sessionrestore_no_auto_restore']}, 04:57:05 INFO - 'other_l64': {'tests': ['a11yr', 04:57:05 INFO - 'ts_paint', 04:57:05 INFO - 'tpaint', 04:57:05 INFO - 'sessionrestore', 04:57:05 INFO - 'sessionrestore_no_auto_restore']}, 04:57:05 INFO - 'other_nol64': {'tests': ['a11yr', 04:57:05 INFO - 'ts_paint', 04:57:05 INFO - 'tpaint', 04:57:05 INFO - 'sessionrestore', 04:57:05 INFO - 'sessionrestore_no_auto_restore']}, 04:57:05 INFO - 'svgr': {'tests': ['tsvgx', 04:57:05 INFO - 'tsvgr_opacity', 04:57:05 INFO - 'tart', 04:57:05 INFO - 'tscrollx', 04:57:05 INFO - 'cart']}, 04:57:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:57:05 INFO - 'tests': ['tsvgx', 04:57:05 INFO - 'tsvgr_opacity', 04:57:05 INFO - 'tart', 04:57:05 INFO - 'tscrollx', 04:57:05 INFO - 'cart']}, 04:57:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:05 INFO - 'tests': ['tp5o']}, 04:57:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:05 INFO - 'talos_options': ['--e10s'], 04:57:05 INFO - 'tests': ['tp5o']}, 04:57:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:05 INFO - 'talos_options': ['--xperf_path', 04:57:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:05 INFO - 'tests': ['tp5n']}, 04:57:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:05 INFO - 'talos_options': ['--e10s', 04:57:05 INFO - '--xperf_path', 04:57:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:05 INFO - 'tests': ['tp5n']}}, 04:57:05 INFO - 'talos.zip': {'path': '', 04:57:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:57:05 INFO - Running post-action listener: _resource_record_post_action 04:57:05 INFO - ##### 04:57:05 INFO - ##### Running create-virtualenv step. 04:57:05 INFO - ##### 04:57:05 INFO - Running pre-action listener: _resource_record_pre_action 04:57:05 INFO - Running main action method: create_virtualenv 04:57:05 INFO - Creating virtualenv /builds/slave/test/build/venv 04:57:05 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 04:57:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:57:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:57:05 INFO - Using real prefix '/usr' 04:57:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:57:06 INFO - Installing distribute.............................................................................................................................................................................................done. 04:57:08 INFO - Installing pip.................done. 04:57:08 INFO - Return code: 0 04:57:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:57:08 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')]} 04:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:08 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')]} 04:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:08 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 0x7fac5df19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c240b0>, '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 0x1c24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c25440>, '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': '447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508', '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 04:57:08 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 04:57:08 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 04:57:08 INFO - Using env: {'DISPLAY': ':0', 04:57:08 INFO - 'HOME': '/home/cltbld', 04:57:08 INFO - 'LANG': 'en_US.UTF-8', 04:57:08 INFO - 'LANGUAGE': 'en_US:en', 04:57:08 INFO - 'LOGNAME': 'cltbld', 04:57:08 INFO - 'MAIL': '/var/mail/cltbld', 04:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:08 INFO - 'MOZ_NO_REMOTE': '1', 04:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:08 INFO - 'NO_EM_RESTART': '1', 04:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:08 INFO - 'PWD': '/builds/slave/test', 04:57:08 INFO - 'SHELL': '/bin/bash', 04:57:08 INFO - 'SHLVL': '1', 04:57:08 INFO - 'TERM': 'linux', 04:57:08 INFO - 'TMOUT': '86400', 04:57:08 INFO - 'USER': 'cltbld', 04:57:08 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508', 04:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:08 INFO - '_': '/tools/buildbot/bin/python'} 04:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:08 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 04:57:08 INFO - Cleaning up... 04:57:08 INFO - Return code: 0 04:57:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:57:08 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')]} 04:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:08 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')]} 04:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:08 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 0x7fac5df19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c240b0>, '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 0x1c24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c25440>, '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': '447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508', '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 04:57:08 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 04:57:08 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 04:57:08 INFO - Using env: {'DISPLAY': ':0', 04:57:08 INFO - 'HOME': '/home/cltbld', 04:57:08 INFO - 'LANG': 'en_US.UTF-8', 04:57:08 INFO - 'LANGUAGE': 'en_US:en', 04:57:08 INFO - 'LOGNAME': 'cltbld', 04:57:08 INFO - 'MAIL': '/var/mail/cltbld', 04:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:08 INFO - 'MOZ_NO_REMOTE': '1', 04:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:08 INFO - 'NO_EM_RESTART': '1', 04:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:08 INFO - 'PWD': '/builds/slave/test', 04:57:08 INFO - 'SHELL': '/bin/bash', 04:57:08 INFO - 'SHLVL': '1', 04:57:08 INFO - 'TERM': 'linux', 04:57:08 INFO - 'TMOUT': '86400', 04:57:08 INFO - 'USER': 'cltbld', 04:57:08 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508', 04:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:08 INFO - '_': '/tools/buildbot/bin/python'} 04:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:08 INFO - Downloading/unpacking psutil>=0.7.1 04:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:10 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:57:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:57:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:57:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:10 INFO - Installing collected packages: psutil 04:57:10 INFO - Running setup.py install for psutil 04:57:10 INFO - building 'psutil._psutil_linux' extension 04:57:10 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 04:57:11 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 04:57:11 INFO - building 'psutil._psutil_posix' extension 04:57:11 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 04:57:11 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 04:57:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:11 INFO - Successfully installed psutil 04:57:11 INFO - Cleaning up... 04:57:11 INFO - Return code: 0 04:57:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:57:11 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')]} 04:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:11 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')]} 04:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:11 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 0x7fac5df19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c240b0>, '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 0x1c24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c25440>, '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': '447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508', '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 04:57:11 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 04:57:11 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 04:57:11 INFO - Using env: {'DISPLAY': ':0', 04:57:11 INFO - 'HOME': '/home/cltbld', 04:57:11 INFO - 'LANG': 'en_US.UTF-8', 04:57:11 INFO - 'LANGUAGE': 'en_US:en', 04:57:11 INFO - 'LOGNAME': 'cltbld', 04:57:11 INFO - 'MAIL': '/var/mail/cltbld', 04:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:11 INFO - 'MOZ_NO_REMOTE': '1', 04:57:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:11 INFO - 'NO_EM_RESTART': '1', 04:57:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:11 INFO - 'PWD': '/builds/slave/test', 04:57:11 INFO - 'SHELL': '/bin/bash', 04:57:11 INFO - 'SHLVL': '1', 04:57:11 INFO - 'TERM': 'linux', 04:57:11 INFO - 'TMOUT': '86400', 04:57:11 INFO - 'USER': 'cltbld', 04:57:11 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508', 04:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:11 INFO - '_': '/tools/buildbot/bin/python'} 04:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:57:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:57:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:57:13 INFO - Installing collected packages: mozsystemmonitor 04:57:13 INFO - Running setup.py install for mozsystemmonitor 04:57:13 INFO - Successfully installed mozsystemmonitor 04:57:13 INFO - Cleaning up... 04:57:13 INFO - Return code: 0 04:57:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:57:13 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')]} 04:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:13 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')]} 04:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:13 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 0x7fac5df19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c240b0>, '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 0x1c24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c25440>, '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': '447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508', '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 04:57:13 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 04:57:13 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 04:57:13 INFO - Using env: {'DISPLAY': ':0', 04:57:13 INFO - 'HOME': '/home/cltbld', 04:57:13 INFO - 'LANG': 'en_US.UTF-8', 04:57:13 INFO - 'LANGUAGE': 'en_US:en', 04:57:13 INFO - 'LOGNAME': 'cltbld', 04:57:13 INFO - 'MAIL': '/var/mail/cltbld', 04:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:13 INFO - 'MOZ_NO_REMOTE': '1', 04:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:13 INFO - 'NO_EM_RESTART': '1', 04:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:13 INFO - 'PWD': '/builds/slave/test', 04:57:13 INFO - 'SHELL': '/bin/bash', 04:57:13 INFO - 'SHLVL': '1', 04:57:13 INFO - 'TERM': 'linux', 04:57:13 INFO - 'TMOUT': '86400', 04:57:13 INFO - 'USER': 'cltbld', 04:57:13 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508', 04:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:13 INFO - '_': '/tools/buildbot/bin/python'} 04:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:13 INFO - Downloading/unpacking blobuploader==1.2.4 04:57:13 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 04:57:13 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 04:57:13 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 04:57:13 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 04:57:13 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 04:57:13 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 04:57:15 INFO - Downloading blobuploader-1.2.4.tar.gz 04:57:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:57:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:57:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:57:15 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 04:57:15 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 04:57:15 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 04:57:15 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 04:57:15 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 04:57:15 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 04:57:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:57:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:57:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:57:15 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 04:57:15 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 04:57:15 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 04:57:15 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 04:57:15 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 04:57:15 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 04:57:16 INFO - Downloading docopt-0.6.1.tar.gz 04:57:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:57:16 INFO - Installing collected packages: blobuploader, requests, docopt 04:57:16 INFO - Running setup.py install for blobuploader 04:57:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:57:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:57:16 INFO - Running setup.py install for requests 04:57:16 INFO - Running setup.py install for docopt 04:57:16 INFO - Successfully installed blobuploader requests docopt 04:57:16 INFO - Cleaning up... 04:57:16 INFO - Return code: 0 04:57:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57: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')]} 04:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57: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')]} 04:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:16 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 0x7fac5df19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c240b0>, '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 0x1c24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c25440>, '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': '447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508', '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 04:57:16 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 04:57:16 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 04:57:16 INFO - Using env: {'DISPLAY': ':0', 04:57:16 INFO - 'HOME': '/home/cltbld', 04:57:16 INFO - 'LANG': 'en_US.UTF-8', 04:57:16 INFO - 'LANGUAGE': 'en_US:en', 04:57:16 INFO - 'LOGNAME': 'cltbld', 04:57:16 INFO - 'MAIL': '/var/mail/cltbld', 04:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:16 INFO - 'MOZ_NO_REMOTE': '1', 04:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:16 INFO - 'NO_EM_RESTART': '1', 04:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:16 INFO - 'PWD': '/builds/slave/test', 04:57:16 INFO - 'SHELL': '/bin/bash', 04:57:16 INFO - 'SHLVL': '1', 04:57:16 INFO - 'TERM': 'linux', 04:57:16 INFO - 'TMOUT': '86400', 04:57:16 INFO - 'USER': 'cltbld', 04:57:16 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508', 04:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:16 INFO - '_': '/tools/buildbot/bin/python'} 04:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:57:16 INFO - Running setup.py (path:/tmp/pip-O2Je3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:57:16 INFO - Running setup.py (path:/tmp/pip-630h6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:57:17 INFO - Running setup.py (path:/tmp/pip-_ke3cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:57:17 INFO - Running setup.py (path:/tmp/pip-EHMhKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:57:17 INFO - Running setup.py (path:/tmp/pip-12f0Li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:57:17 INFO - Running setup.py (path:/tmp/pip-hiX8g9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:57:17 INFO - Running setup.py (path:/tmp/pip-yQgw0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:57:17 INFO - Running setup.py (path:/tmp/pip-JEwNk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:57:17 INFO - Running setup.py (path:/tmp/pip-LZtL1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:57:17 INFO - Running setup.py (path:/tmp/pip-9iB23H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:57:17 INFO - Running setup.py (path:/tmp/pip-vMNgiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:57:17 INFO - Running setup.py (path:/tmp/pip-jRRrSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:57:17 INFO - Running setup.py (path:/tmp/pip-hmAz6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:57:17 INFO - Running setup.py (path:/tmp/pip-btcTu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:17 INFO - Running setup.py (path:/tmp/pip-zOaDvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:57:17 INFO - Running setup.py (path:/tmp/pip-cLg4FZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:57:18 INFO - Running setup.py (path:/tmp/pip-duyP7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:57:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:57:18 INFO - Running setup.py install for manifestparser 04:57:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:57:18 INFO - Running setup.py install for mozcrash 04:57:18 INFO - Running setup.py install for mozdebug 04:57:18 INFO - Running setup.py install for mozdevice 04:57:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:57:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:57:18 INFO - Running setup.py install for mozfile 04:57:18 INFO - Running setup.py install for mozhttpd 04:57:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:57:18 INFO - Running setup.py install for mozinfo 04:57:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:57:18 INFO - Running setup.py install for mozInstall 04:57:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:57:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:57:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:57:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:57:18 INFO - Running setup.py install for mozleak 04:57:19 INFO - Running setup.py install for mozlog 04:57:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:57:19 INFO - Running setup.py install for moznetwork 04:57:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:57:19 INFO - Running setup.py install for mozprocess 04:57:19 INFO - Running setup.py install for mozprofile 04:57:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:57:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:57:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:57:19 INFO - Running setup.py install for mozrunner 04:57:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:57:19 INFO - Running setup.py install for mozscreenshot 04:57:19 INFO - Running setup.py install for moztest 04:57:19 INFO - Running setup.py install for mozversion 04:57:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:57:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:57:19 INFO - Cleaning up... 04:57:19 INFO - Return code: 0 04:57:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:19 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')]} 04:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:19 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')]} 04:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:19 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 0x7fac5df19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c240b0>, '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 0x1c24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c25440>, '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': '447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508', '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 04:57:19 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 04:57:19 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 04:57:19 INFO - Using env: {'DISPLAY': ':0', 04:57:19 INFO - 'HOME': '/home/cltbld', 04:57:19 INFO - 'LANG': 'en_US.UTF-8', 04:57:19 INFO - 'LANGUAGE': 'en_US:en', 04:57:19 INFO - 'LOGNAME': 'cltbld', 04:57:19 INFO - 'MAIL': '/var/mail/cltbld', 04:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:19 INFO - 'MOZ_NO_REMOTE': '1', 04:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:19 INFO - 'NO_EM_RESTART': '1', 04:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:19 INFO - 'PWD': '/builds/slave/test', 04:57:19 INFO - 'SHELL': '/bin/bash', 04:57:19 INFO - 'SHLVL': '1', 04:57:19 INFO - 'TERM': 'linux', 04:57:19 INFO - 'TMOUT': '86400', 04:57:19 INFO - 'USER': 'cltbld', 04:57:19 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508', 04:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:19 INFO - '_': '/tools/buildbot/bin/python'} 04:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:57:20 INFO - Running setup.py (path:/tmp/pip-7yq_dA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:57:20 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)) 04:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:57:20 INFO - Running setup.py (path:/tmp/pip-jNTpmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:57:20 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)) 04:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:57:20 INFO - Running setup.py (path:/tmp/pip-6QbBCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:57:20 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)) 04:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:57:20 INFO - Running setup.py (path:/tmp/pip-iz9eJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:57:20 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)) 04:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:57:20 INFO - Running setup.py (path:/tmp/pip-pDoy5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:57:20 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)) 04:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:57:20 INFO - Running setup.py (path:/tmp/pip-_TexUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:57:20 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)) 04:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:57:20 INFO - Running setup.py (path:/tmp/pip-djnX_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:57:20 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)) 04:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:57:20 INFO - Running setup.py (path:/tmp/pip-FYG3Xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:57:20 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)) 04:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:57:20 INFO - Running setup.py (path:/tmp/pip-HlVY67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:57:20 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)) 04:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:57:20 INFO - Running setup.py (path:/tmp/pip-liCCUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:57:20 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)) 04:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:57:20 INFO - Running setup.py (path:/tmp/pip-xxiKPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:57:20 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)) 04:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:57:20 INFO - Running setup.py (path:/tmp/pip-8bu0SP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:57:20 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)) 04:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:57:21 INFO - Running setup.py (path:/tmp/pip-U8Ayqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:57:21 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)) 04:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:57:21 INFO - Running setup.py (path:/tmp/pip-bN2c7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:57:21 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)) 04:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:21 INFO - Running setup.py (path:/tmp/pip-cFyJ6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:21 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)) 04:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:57:21 INFO - Running setup.py (path:/tmp/pip-B7g34j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:57:21 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)) 04:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:57:21 INFO - Running setup.py (path:/tmp/pip-jDJojj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:57:21 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)) 04:57:21 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)) 04:57:21 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)) 04:57:21 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)) 04:57:21 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)) 04:57:21 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)) 04:57:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:57:21 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 04:57:21 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 04:57:21 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 04:57:21 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 04:57:21 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 04:57:21 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 04:57:23 INFO - Downloading blessings-1.5.1.tar.gz 04:57:23 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 04:57:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:57:23 INFO - Installing collected packages: blessings 04:57:23 INFO - Running setup.py install for blessings 04:57:23 INFO - Successfully installed blessings 04:57:23 INFO - Cleaning up... 04:57:23 INFO - Return code: 0 04:57:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:57:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:57:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:57:23 INFO - Reading from file tmpfile_stdout 04:57:23 INFO - Current package versions: 04:57:23 INFO - argparse == 1.2.1 04:57:23 INFO - blessings == 1.5.1 04:57:23 INFO - blobuploader == 1.2.4 04:57:23 INFO - docopt == 0.6.1 04:57:23 INFO - manifestparser == 1.1 04:57:23 INFO - mozInstall == 1.12 04:57:23 INFO - mozcrash == 0.16 04:57:23 INFO - mozdebug == 0.1 04:57:23 INFO - mozdevice == 0.47 04:57:23 INFO - mozfile == 1.2 04:57:23 INFO - mozhttpd == 0.7 04:57:23 INFO - mozinfo == 0.9 04:57:23 INFO - mozleak == 0.1 04:57:23 INFO - mozlog == 3.1 04:57:23 INFO - moznetwork == 0.27 04:57:23 INFO - mozprocess == 0.22 04:57:23 INFO - mozprofile == 0.27 04:57:23 INFO - mozrunner == 6.11 04:57:23 INFO - mozscreenshot == 0.1 04:57:23 INFO - mozsystemmonitor == 0.0 04:57:23 INFO - moztest == 0.7 04:57:23 INFO - mozversion == 1.4 04:57:23 INFO - psutil == 3.1.1 04:57:23 INFO - requests == 1.2.3 04:57:23 INFO - wsgiref == 0.1.2 04:57:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:23 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')]} 04:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:23 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')]} 04:57:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:23 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 0x7fac5df19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c240b0>, '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 0x1c24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c25440>, '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': '447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508', '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 04:57:23 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 04:57:23 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 04:57:23 INFO - Using env: {'DISPLAY': ':0', 04:57:23 INFO - 'HOME': '/home/cltbld', 04:57:23 INFO - 'LANG': 'en_US.UTF-8', 04:57:23 INFO - 'LANGUAGE': 'en_US:en', 04:57:23 INFO - 'LOGNAME': 'cltbld', 04:57:23 INFO - 'MAIL': '/var/mail/cltbld', 04:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:23 INFO - 'MOZ_NO_REMOTE': '1', 04:57:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:23 INFO - 'NO_EM_RESTART': '1', 04:57:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:23 INFO - 'PWD': '/builds/slave/test', 04:57:23 INFO - 'SHELL': '/bin/bash', 04:57:23 INFO - 'SHLVL': '1', 04:57:23 INFO - 'TERM': 'linux', 04:57:23 INFO - 'TMOUT': '86400', 04:57:23 INFO - 'USER': 'cltbld', 04:57:23 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508', 04:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:23 INFO - '_': '/tools/buildbot/bin/python'} 04:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:23 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)) 04:57:23 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)) 04:57:23 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)) 04:57:23 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)) 04:57:23 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)) 04:57:23 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)) 04:57:23 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)) 04:57:23 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)) 04:57:23 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)) 04:57:23 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)) 04:57:23 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)) 04:57:23 INFO - Cleaning up... 04:57:23 INFO - Return code: 0 04:57:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:57:23 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')]} 04:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:23 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')]} 04:57:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:23 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 0x7fac5df19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c240b0>, '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 0x1c24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c25440>, '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': '447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508', '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 04:57:23 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 04:57:23 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 04:57:23 INFO - Using env: {'DISPLAY': ':0', 04:57:23 INFO - 'HOME': '/home/cltbld', 04:57:23 INFO - 'LANG': 'en_US.UTF-8', 04:57:23 INFO - 'LANGUAGE': 'en_US:en', 04:57:23 INFO - 'LOGNAME': 'cltbld', 04:57:23 INFO - 'MAIL': '/var/mail/cltbld', 04:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:23 INFO - 'MOZ_NO_REMOTE': '1', 04:57:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:23 INFO - 'NO_EM_RESTART': '1', 04:57:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:23 INFO - 'PWD': '/builds/slave/test', 04:57:23 INFO - 'SHELL': '/bin/bash', 04:57:23 INFO - 'SHLVL': '1', 04:57:23 INFO - 'TERM': 'linux', 04:57:23 INFO - 'TMOUT': '86400', 04:57:23 INFO - 'USER': 'cltbld', 04:57:23 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508', 04:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:23 INFO - '_': '/tools/buildbot/bin/python'} 04:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:23 INFO - Downloading/unpacking jsonschema 04:57:23 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 04:57:23 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 04:57:23 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 04:57:23 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 04:57:23 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 04:57:23 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 04:57:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:57:25 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 04:57:25 INFO - Downloading/unpacking functools32 (from jsonschema) 04:57:25 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 04:57:25 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 04:57:25 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 04:57:25 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 04:57:25 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 04:57:25 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 04:57:25 INFO - Downloading functools32-3.2.3-2.tar.gz 04:57:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:57:25 INFO - warning: no files found matching '*.txt' 04:57:25 INFO - no previously-included directories found matching 'build' 04:57:25 INFO - no previously-included directories found matching 'dist' 04:57:25 INFO - no previously-included directories found matching '.git*' 04:57:25 INFO - Installing collected packages: jsonschema, functools32 04:57:25 INFO - Running setup.py install for functools32 04:57:25 INFO - warning: no files found matching '*.txt' 04:57:26 INFO - no previously-included directories found matching 'build' 04:57:26 INFO - no previously-included directories found matching 'dist' 04:57:26 INFO - no previously-included directories found matching '.git*' 04:57:26 INFO - Successfully installed jsonschema functools32 04:57:26 INFO - Cleaning up... 04:57:26 INFO - Return code: 0 04:57:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:57:26 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')]} 04:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:26 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')]} 04:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:26 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 0x7fac5df19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c240b0>, '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 0x1c24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c25440>, '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': '447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508', '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 04:57:26 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 04:57:26 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 04:57:26 INFO - Using env: {'DISPLAY': ':0', 04:57:26 INFO - 'HOME': '/home/cltbld', 04:57:26 INFO - 'LANG': 'en_US.UTF-8', 04:57:26 INFO - 'LANGUAGE': 'en_US:en', 04:57:26 INFO - 'LOGNAME': 'cltbld', 04:57:26 INFO - 'MAIL': '/var/mail/cltbld', 04:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:26 INFO - 'MOZ_NO_REMOTE': '1', 04:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:26 INFO - 'NO_EM_RESTART': '1', 04:57:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:26 INFO - 'PWD': '/builds/slave/test', 04:57:26 INFO - 'SHELL': '/bin/bash', 04:57:26 INFO - 'SHLVL': '1', 04:57:26 INFO - 'TERM': 'linux', 04:57:26 INFO - 'TMOUT': '86400', 04:57:26 INFO - 'USER': 'cltbld', 04:57:26 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508', 04:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:26 INFO - '_': '/tools/buildbot/bin/python'} 04:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:26 INFO - Downloading/unpacking flake8 04:57:26 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 04:57:26 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 04:57:26 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 04:57:26 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 04:57:26 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 04:57:26 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 04:57:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:57:27 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 04:57:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:57:27 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 04:57:27 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 04:57:27 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 04:57:27 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 04:57:27 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 04:57:27 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 04:57:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:57:28 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 04:57:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:57:28 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 04:57:28 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 04:57:28 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 04:57:28 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 04:57:28 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 04:57:28 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 04:57:28 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 04:57:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:57:28 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 04:57:28 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 04:57:28 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 04:57:28 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 04:57:28 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 04:57:28 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 04:57:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:57:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:57:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:57:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:57:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:57:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:57:28 INFO - no previously-included directories found matching 'docs/_build' 04:57:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:57:28 INFO - Running setup.py install for pep8 04:57:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:57:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:57:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:57:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:57:28 INFO - no previously-included directories found matching 'docs/_build' 04:57:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:57:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:57:28 INFO - Cleaning up... 04:57:28 INFO - Return code: 0 04:57:28 INFO - Running post-action listener: _resource_record_post_action 04:57:28 INFO - Running post-action listener: _start_resource_monitoring 04:57:28 INFO - Starting resource monitoring. 04:57:28 INFO - ##### 04:57:28 INFO - ##### Running install step. 04:57:28 INFO - ##### 04:57:28 INFO - Running pre-action listener: _resource_record_pre_action 04:57:28 INFO - Running main action method: install 04:57:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:57:29 INFO - Reading from file tmpfile_stdout 04:57:29 INFO - Detecting whether we're running mozinstall >=1.0... 04:57:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:57:29 INFO - Reading from file tmpfile_stdout 04:57:29 INFO - Output received: 04:57:29 INFO - Usage: mozinstall [options] installer 04:57:29 INFO - Options: 04:57:29 INFO - -h, --help show this help message and exit 04:57:29 INFO - -d DEST, --destination=DEST 04:57:29 INFO - Directory to install application into. [default: 04:57:29 INFO - "/builds/slave/test"] 04:57:29 INFO - --app=APP Application being installed. [default: firefox] 04:57:29 INFO - mkdir: /builds/slave/test/build/application 04:57:29 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'] 04:57:29 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 04:57:45 INFO - Reading from file tmpfile_stdout 04:57:45 INFO - Output received: 04:57:45 INFO - /builds/slave/test/build/application/firefox/firefox 04:57:45 INFO - Running post-action listener: _resource_record_post_action 04:57:45 INFO - ##### 04:57:45 INFO - ##### Running run-tests step. 04:57:45 INFO - ##### 04:57:45 INFO - Running pre-action listener: _resource_record_pre_action 04:57:45 INFO - Running main action method: run_tests 04:57:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:57:45 INFO - Python 2.7.3 04:57:45 INFO - Return code: 0 04:57:45 INFO - grabbing minidump binary from tooltool 04:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:45 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 0x1c240b0>, '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 0x1c24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c25440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:57:45 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 04:57:45 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 04:57:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:57:45 INFO - Return code: 0 04:57:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:57:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:57:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:57:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:57:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:57:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:57:46 INFO - Return code: 0 04:57:46 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/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] in /builds/slave/test/build 04:57:46 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/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost 04:57:46 INFO - Using env: {'DISPLAY': ':0', 04:57:46 INFO - 'HOME': '/home/cltbld', 04:57:46 INFO - 'LANG': 'en_US.UTF-8', 04:57:46 INFO - 'LANGUAGE': 'en_US:en', 04:57:46 INFO - 'LOGNAME': 'cltbld', 04:57:46 INFO - 'MAIL': '/var/mail/cltbld', 04:57:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:57:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:57:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:46 INFO - 'MOZ_NO_REMOTE': '1', 04:57:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:57:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:46 INFO - 'NO_EM_RESTART': '1', 04:57:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:46 INFO - 'PWD': '/builds/slave/test', 04:57:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:57:46 INFO - 'SHELL': '/bin/bash', 04:57:46 INFO - 'SHLVL': '1', 04:57:46 INFO - 'TERM': 'linux', 04:57:46 INFO - 'TMOUT': '86400', 04:57:46 INFO - 'USER': 'cltbld', 04:57:46 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508', 04:57:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:46 INFO - '_': '/tools/buildbot/bin/python'} 04:57:46 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/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] with output_timeout 3600 04:57:46 INFO - mozversion INFO | application_buildid: 20151218042953 04:57:46 INFO - mozversion INFO | application_changeset: ff3fcdae5d51b69077bf1d410350c2fc6b2131e0 04:57:46 INFO - mozversion INFO | application_display_name: Nightly 04:57:46 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:57:46 INFO - mozversion INFO | application_name: Firefox 04:57:46 INFO - mozversion INFO | application_remotingname: firefox 04:57:46 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:57:46 INFO - mozversion INFO | application_vendor: Mozilla 04:57:46 INFO - mozversion INFO | application_version: 46.0a1 04:57:46 INFO - mozversion INFO | platform_buildid: 20151218042953 04:57:46 INFO - mozversion INFO | platform_changeset: ff3fcdae5d51b69077bf1d410350c2fc6b2131e0 04:57:46 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:57:46 INFO - mozversion INFO | platform_version: 46.0a1 04:57:46 INFO - 2015-12-18 04:57:46,406 DEBUG : using testdate: 1450443466 04:57:46 INFO - 2015-12-18 04:57:46,406 DEBUG : actual date: 1450443466 04:57:46 INFO - 2015-12-18 04:57:46,415 INFO : starting webserver on 'localhost:37027' 04:57:46 INFO - 2015-12-18 04:57:46,416 INFO : Starting test suite talos-linux64-ix-027 04:57:46 INFO - 2015-12-18 04:57:46,417 INFO : Starting test dromaeo_css 04:57:46 INFO - 2015-12-18 04:57:46,417 DEBUG : operating with platform_type : linux_ 04:57:46 INFO - 2015-12-18 04:57:46,417 INFO : Initialising browser for dromaeo_css test... 04:57:46 INFO - 2015-12-18 04:57:46,429 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSAtJAE/profile http://localhost:37027/getInfo.html 04:57:51 INFO - 2015-12-18 04:57:51,029 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:57:51 INFO - 2015-12-18 04:57:51,029 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:57:51 INFO - 2015-12-18 04:57:51,029 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:57:51 INFO - 2015-12-18 04:57:51,029 DEBUG : BROWSER_OUTPUT: __metrics 04:57:51 INFO - 2015-12-18 04:57:51,113 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] 04:57:51 INFO - 2015-12-18 04:57:51,181 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] 04:57:52 INFO - 2015-12-18 04:57:52,400 INFO : Browser initialized. 04:57:52 INFO - 2015-12-18 04:57:52,401 INFO : Running cycle 1/1 for dromaeo_css test... 04:57:52 INFO - 2015-12-18 04:57:52,401 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSAtJAE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:58:04 INFO - 2015-12-18 04:58:04,438 DEBUG : BROWSER_OUTPUT: RSS: Main: 149938176 04:58:04 INFO - 2015-12-18 04:58:04,438 DEBUG : BROWSER_OUTPUT: 04:58:55 INFO - 2015-12-18 04:58:55,944 DEBUG : BROWSER_OUTPUT: 1450443535942 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] 05:01:08 INFO - 2015-12-18 05:01:08,165 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37027/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37027/tests/dromaeo/cssquery-ext.html) 05:01:09 INFO - 2015-12-18 05:01:09,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 254287872 05:01:09 INFO - 2015-12-18 05:01:09,290 DEBUG : BROWSER_OUTPUT: 05:04:11 INFO - 2015-12-18 05:04:11,898 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37027/tests/dromaeo/cssquery-ext.html (next: http://localhost:37027/tests/dromaeo/cssquery-jquery.html) 05:04:12 INFO - 2015-12-18 05:04:12,480 DEBUG : BROWSER_OUTPUT: RSS: Main: 224858112 05:04:12 INFO - 2015-12-18 05:04:12,480 DEBUG : BROWSER_OUTPUT: 05:07:14 INFO - 2015-12-18 05:07:14,567 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37027/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37027/tests/dromaeo/cssquery-mootools.html) 05:07:15 INFO - 2015-12-18 05:07:15,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 225562624 05:07:15 INFO - 2015-12-18 05:07:15,149 DEBUG : BROWSER_OUTPUT: 05:10:17 INFO - 2015-12-18 05:10:17,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37027/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37027/tests/dromaeo/cssquery-prototype.html) 05:10:17 INFO - 2015-12-18 05:10:17,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 214925312 05:10:17 INFO - 2015-12-18 05:10:17,627 DEBUG : BROWSER_OUTPUT: 05:13:20 INFO - 2015-12-18 05:13:20,435 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37027/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37027/tests/dromaeo/cssquery-yui.html) 05:13:21 INFO - 2015-12-18 05:13:21,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 192679936 05:13:21 INFO - 2015-12-18 05:13:21,022 DEBUG : BROWSER_OUTPUT: 05:16:23 INFO - 2015-12-18 05:16:23,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37027/tests/dromaeo/cssquery-yui.html (next: http://localhost:37027/tests/dromaeo/cssquery-dojo.html) 05:16:23 INFO - 2015-12-18 05:16:23,751 DEBUG : BROWSER_OUTPUT: RSS: Main: 260501504 05:16:23 INFO - 2015-12-18 05:16:23,752 DEBUG : BROWSER_OUTPUT: 05:16:23 INFO - 2015-12-18 05:16:23,752 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:16:23 INFO - 2015-12-18 05:16:23,752 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:16:23 INFO - 2015-12-18 05:16:23,752 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:16:23 INFO - 2015-12-18 05:16:23,752 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:16:23 INFO - 2015-12-18 05:16:23,753 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2597.5324441600515;2692.0712354237808;2695.7458695825694;2703.0674417326027;2719.673639163301;4496.550344965502;4644.256918892977;4682.297655351699;4691.648126390517;4702.506236845129;4612.285095810146;4643.512431194727;4713.434387873452;4757.1437141314545;4760.8095676173;4333.609975102248;4347.434833471644;4378.058717375764;4399.42807435033;4421.292593185091;4441.578050085237;4459.130469558438;4482.260427029552;4486.730796152225;4511.030128522367;4197.8320867165585;4213.47331583552;4305.935410968838;4312;4319.935200971988;4344.45694288214;4359.38968544404;4369;4379.868603941887;4400.647948164139;4312.029793296515;4344.066025804435;4345.456817897762;4360.825566977317;4369.169857727054;4467.285234362519;4566.634669226454;4581.5647513486165;4596.862094137181;4687.039156972813;5049.394072711299;5061.240813877911;5077.822276220351;5095.515925987025;5108.029474399852;5072;5075.822346217865;5083.87290317745;5087.516685914832;5127.512886275797;4471.5081341052455;4571.474280457724;4677.4854765975715;4691.718496890129;4699.577038066591;5060.2662613920775;5077.035363280965;5193.195054766517;5196.32447781786;5205.375354957429;4951.529604687549;5002.199648056367;5017.7491125443585;5025.14572522672;5027.345184567563;4783.832565860178;4925.990172014728;5105.7191854448365;5115.130427827278;5136;4875.829345972874;4907.509249075064;4986.426560945465;4988.55103040728;4997.425296090923;4910.017996400734;4917.434495033117;4920.286558449005;4957.405111386584;4980.377452818398;3995.440638310639;4133.338665813516;4167.166566686675;4180.770057646798;4207.200631879933;3609.4766258892314;3670.7614005089586;3676.0258531489176;3697.685696715809;3716.201016781405;4280.978595107004;4294.29144191205;4301.849435269751;4303.63419109373;4340.52254252032;4852.636052296092;4986.052649996489;5006.924896126561;5018.4981501849525;5054.317667114966;4235.343521754133;4267.573242675708;4304.526502084768;4306.676999225071;4344.630706389992;4461.040876211565;4499.617532509707;4504.8423305184815;4513.887152821206;4550.340200670884;4590;4714.622830173509;4838.153323168502;4851.393575803025;4857.514248575114;4922.433920099091;4951.653384263067;4993.076280888047;5020.523050310215;5064.41759197697;4835.6131509479865;4837.032593481388;4841.612670986242;4845.370101886732;4888.2178851383605;4741.525847415369;4851.078295123915;5053.69677819332;5060.038592667382;5094.541491265803;4916.92624610624;5019.472955339783;5135.845924622267;5141.100307446257;5160.406553246425;4911.0423467424935;4911.68074075184;4916.7541622919425;4922.040202160544;4963.181075122564;4741.549552792617;4879.95120048795;4918.5573298403315;4927.359443272351;4970.975145124251;4714.834980775657;4729.55069268419;4768.1417344878255;4789.9042019160115;4802.807887684454;4922.975385123052;4936.605071594192;4941.308216849572;4941.678790878582;4958.380202474691;4618.722876627278;4748.3352330674425;4823.3729615149805;4831.541003604652;4831.806727730851 05:16:23 INFO - 2015-12-18 05:16:23,753 DEBUG : BROWSER_OUTPUT: |1;ext.html;558.7429782300142;566.4024454200817;570.3526497425422;580.7909152705025;581.226968132384;27392.726072739293;28123.015694450725;28127;35895.820520897425;36535;40749;41346.7932660337;41376.58623413765;41409.792951035204;41467.37798933018;7832.216778322179;7938.245866642688;8002.079760827522;8007.879881801778;8009.078955920057;7030.26182250864;7193.568385896837;10242.487875606228;10483.737906552358;10488.265821392506;10084.546195421224;10239.744006399826;10246.333988290737;10247.077763001329;10251.897481025206;7179.856402871966;7364.96317518409;9984.600615975352;10081.092701656886;10099.091081802673;7069.823254418629;10246;10528.894711052868;10529.262951593391;10545.050945414949;37504;37592.24815503702;37688.43467347965;37785.43321850174;38014.049648759;2834.4472827798586;3569.089882080079;3614.2952124335766;3616;3666.7616604920595;28561.71438285632;28629.57055644167;28658.426831463254;28750.856245718845;28964.565531517044;3453.723702103826;3457.3085382923514;3492.14442461596;3614.34941710492;3688.483612294281;215885;218219;218535;218771;218899;44642.776786115865;47620.7618961903;47654.28518572224;55414.72292638511;56925.71537142371;48286;48499.75750121227;48602.756986214845;48637.270440943415;48699.75650121726;12725.93637031809;12861.935690321488;12896.484140634457;12903.161294515827;12907.612771616867;9553.426794392359;9611.807763844685;9635.710928672152;9736.172425343924;9738.853917191247;18804.623907522047;18942.147603357884;18945.621087578173;18965.715514267296;19010.80989190118;7175.533590316612;7272.709091636381;7375.078115235596;7407.111226621621;7451.701931922662;841.5119230846217;866.5797088412115;893.1425831201989;902.8239493298744;996.8903420623726;24424.63363049556;24674.162471316027;24824.875875620506;24851.875740621545;24904.252872413857;956.1872408452759;973.7419583810296;997.7079681812071;1015.4364327797995;1032.963846265377;12423.565175219004;12441.813372799415;12564.685882852818;12587.811182832265;12768.553100641433;266449;271417;271598;271902;271919;44168.3374749379;44628.55371446244;44673;44720.77639611781;44795.32807007898;1081.5133190064503;1137.3858116616934;1172.6540670502222;1253.2678760302447;1259.0745801835826;23059.423514412272;23365.53268934578;23750.762492375547;23973.28080157598;23998;33057;33315.33369332648;33337;33399.666003339655;35814.64185358113;146284;245754;251831;252929;253021;25461.3634659135;25993.22020339393;26022.34944126412;26022.86988565045;26023.479530408906;35282.47076293909;35372;35428.822855885555;35618.821905890305;36265.27469450649;30661;30879.536806948363;30970.690293097683;31394;34533.30933381368;33141.83429082839;33980.32039359149;34159.14602134867;34188.14529636779;34283.142921426166;30777;31589.8420507896;31671.20821979469;31676.841615791775;31679.36641267208;28245.293867653472;28822.855885720437;30229;31230.843845780626;32728.951732218684;22659.886700566392;22848.88720030344;22926.656100158845;22966.655500167177;23143.537129257656 05:16:23 INFO - 2015-12-18 05:16:23,757 DEBUG : BROWSER_OUTPUT: |2;jquery.html;329.14586647649344;333.21029160888696;334.6319049046048;335.42394410924106;335.7817418677859;12600.873991260085;12968.935155324234;14937;15358.846411535882;16027.759583606241;8453.577321133935;9179.403338782991;9470.431774093558;9934.65228716995;10197.745056373595;4410.603045725884;4535.070310586339;4537.160625284317;4537.954620453786;4538.523455037223;3451.050960985724;3551.3785087609695;4494;5015.473375295596;5181.1710126379785;5094.949050509503;5122.129238029525;5145.897082058356;5150.27896094547;5153.793848246066;5136.486351364871;5292.814751483699;5662.150677398382;5662.235598194232;5671.886562268773;5012.373453318335;5014.648974571782;5015.523525265094;5019.899602007976;5024.196128619404;18842.246310147577;18940.90529547357;19540.511487212792;19577.21691132353;19595.90202048995;1755.6664233795539;1905.637928793525;1907.6280125375558;1927.3928712455672;2003.24878170686;8625.784355391103;8698.695545655872;8878.179973105562;8912.019677835433;8973.820523589491;1661.775660285858;1667.4747454551778;1687.7130887749113;1689.5691598642268;1733.340588564096;48775.51224487745;50025.74987125077;50296.748516257554;50631;51266;9542.666006689733;9749.31754777173;9951.950240248752;9953.651622193333;10074.798504029879;12525.749485010248;12590.622281331574;12602.432890519949;12613.684657883627;12620.936895315464;6882.277360877136;6955.652217389212;7005.334493223136;7050.259722729143;7061.788146355618;6696.129503164558;6704.530682852153;6735.966320168368;6754.493412994045;6756.864862702817;4194.727342722713;4223.619874211275;4232.090100628379;4257.148570285955;4257.723247988871;1622.594351412147;1661.036598772733;1664.7669326294329;1685.1826863970964;1768.8761786675066;845.3533047218882;848.0332421040019;949.3829011142813;992.731962370156;996.2528103922059;14541.491047813275;14779.26103694811;15391.92304038495;15978.440754573534;16062.75905861413;765.7358211417052;858.4205661178679;867.2108381372921;906.7143849687327;911.7583840282331;8924.8661270081;9151.496667683208;9217.815643687089;9380.671676491427;9456.101670341306;446033;448676;453542;454663;457178;72456;75757.24242757502;76019.73733546011;76749.23250767421;76846;1088.2327958789035;1088.3469918049266;1100.878903320634;1103.9282446640943;1108.2076315434342;14402.639934001734;14582.85417145815;14624.120392948904;14778.261086945395;14908.18005009735;32159.51760723638;32166.51750223795;33029.66970330266;35201.47197792086;37487;43053.13893722171;43458.2195958438;43687.344689830315;44532.77733611311;45347.77326113348;8577.699780507652;8855.424397414148;9326.626934922528;9336.906630933603;9352.205062569486;16359.918200408922;16414.09722465276;16480.34078636841;16523.50429487069;16830.495085147464;13739.106958047694;13809.381535703535;13871.167729936236;14152.646183845487;14169.504067357593;13588.320583970959;13800.171989680652;13855.930720346334;13971.231582263074;14106.435742570182;10914.890851091388;13201.60395188146;13817.930910345785;14014.36935337892;14279.500217492754;8604.65581376763;8636.913630863863;8771.780705482413;8798.604062817316;8798.97623546575;9261.67584134552;13178.472861085449;13335.199888006751;13601.387937542637;13824.239666818421 05:16:23 INFO - 2015-12-18 05:16:23,758 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1246.3082988941146;1386.1960063163367;1387.5282403982644;1652.0748380906693;1718.8710846686502;6075.331713511516;6895.10363652725;7064.894026589605;7074.610896400696;7082.893756593642;7178.210396856354;7350.705971761136;7356.705731770723;7362.116546014472;7362.337389634932;1769.4249368955077;1793.1124093573699;1804.9097545122756;2065.4320061983;2102.7056212130315;2045.9590808183827;2090.9163633454646;2091.947701307472;2092.0899408757164;2095.5704080663504;2055.701923221132;2067.503799088223;2075.0765909170427;2111.862728922615;2113.598416300898;2063.174730107969;2072.492239401349;2096.7693553709078;2100.464381582702;2104.547522282709;2104.1478201328487;2134.6157691615504;2135.284679632325;2137.9096660703;2138.187488754279;7280.8179795505;7327.377172940306;7333.669984850694;7363.2268611795525;7371.705131794722;4192.664586833046;4276.572342765729;4279.572042795727;4307.870763877088;4309;2595.662563866685;2682.2355628645937;2690.4350086481863;2705.756481916637;2720.659917510311;848.944818586796;854.6282367170301;854.7606670132373;859.7979474823411;871.8605023196258;9906.801863962752;9957.5021248938;9963.352382095212;9969.003099690046;9977.700668979942;3702.5371828521434;3767.171222331083;3830.5020347354666;3835.8082095895093;3838.4626152338697;8556;8564.74305770828;8645.049044605088;8654.307655387554;8654.567271636393;4185.769782661982;4187.6440502557625;4189.2040512302565;4197.013701780079;4201;3794.962050379516;3808.6191380862247;3817.7900215487857;3824.8470061197795;3860.942085868714;3053.7862349635757;3112.4086423579447;3113.112762862573;3456.3260164267726;3549.6627820357025;978.5351957820121;993.5032483758121;1096.8702236696215;1109.1071687291808;1112.5327362507767;879.4503435352905;901.121406628532;972.5526257921435;1181.5628217559558;1182.148852825964;6886.931130688729;6937.895931561031;6997.335253150943;7003.5797852129035;7060.3292687194635;1038.200585549138;1042.3329069395593;1052.9947350263353;1055.5988724284875;1074.7152004718755;5344.984452953926;5429.239906413105;5448.591355648342;5475.808346707926;5478;8330.583470826556;8464.830703385898;8483.194096560817;8636.913630863737;8732.650693972297;8541.615627296787;8542.060373358925;8606.65573377058;8611.224989750952;8650.74047778555;6492.707828147651;6658.4673226141795;6696.531242813054;6702.19573651165;6722.361375669304;7002.334778196063;7027;7056.400205982343;7057.788266352018;7080.2919708028785;7875.842483150191;7967.960160199162;8010.879836802569;8045.919540804517;8060.838783224185;8045.11503734577;8127.3091787198755;8251.669933202846;8265.380096492667;8359.289460395934;6261.655608941552;6331.461825744863;6390.105385245976;6390.297067322684;6401.679916004088;6924.272951340036;7020.122484689414;7022.6488675565;7032.367086962198;7032.753853615099;5540.473655002768;6264.812055638338;6600.669966501559;6604;6777.051212830306;6339.207599050119;6354.301026886947;6373.681315934277;6405.487560995016;6444.871102578016;6542.378474044958;6605.702743376463;6621.172353455818;6631.33686631333;6631.370019848299;5776.508996735324;5800.8259752207505;5803.303603567599;5805.448482394166;5810.680412577349;6124.938750612437;6272.18461599989;6272.4982001440685;6275;6279.183706118175 05:16:23 INFO - 2015-12-18 05:16:23,759 DEBUG : BROWSER_OUTPUT: |4;prototype.html;299.75270401918414;300.1805072153023;304.60401478078506;305.4486651593872;307.8860821496046;5247.317848679671;5260;5361.705106219157;5365.329333833266;5385.973070134643;5218.634695571312;5223;5238.345206849144;5241.39723931747;5248.239005344223;3879.4180872869156;4115.074108325633;4119.752814831105;4120.752754834704;4125.319322311815;3999.2601368746728;4022.4368588397647;4060.634542891139;4076.9592304077023;4082.6937979651498;4046.5953404659595;4084.121913788535;4084.693647976399;4091;4098.7130900836955;3852.595477474853;3951.940720889189;3980.7412518186516;4087.9591204088024;4097.73364731293;3636.6181550937035;3652.561692596879;3654.872079477232;3655.4882316475714;3670.7063434925144;5033.421156566968;5041.59667226621;5052.267421223902;5061.772220250097;5064.468230835746;4746.644001699852;4752.215884379073;4753.714777113384;4755.144074066667;4759.643026772971;5424.728763561806;5541.27963364764;5550.47270509301;5561.610687251894;5579.776808927638;3998.140399814054;3998.460207871929;3999.8000099995174;4001.139754952699;4001.7198796083994;5761.88476230473;5852.034414321632;5852.970735146339;5853.531717462635;5854.912176317359;4049.4735684360844;4064.207479541461;4075.449814275094;4076.613951256528;4078.469798926121;3705.7776533408082;3857.6528112470014;4134.359174327984;4140.254754144283;4143.917121657611;4545.3863728396245;4566.269396896547;4567.269236922077;4574.839880604163;4683.882902927454;5571.777128914798;5575.581831362664;5581.079121944834;5582.944170558324;5591.496765291144;1459.9927000365142;1475.6310922269433;1475.8081449411509;1476.195473466963;1476.7858660494169;992.846108853129;1003.8895721470633;1008.2740426892625;1022.9335093219066;1023.1150055202196;4854;4855.223164293767;4859.684120532154;4863.1732605457155;4864.221724524059;5755.712214389264;5763.279590051244;5769.9711501442225;5773.566982476331;5775.191473193756;4815.012922350909;4841.782119804618;4850.466448690711;4856.39295088114;4859.246816743411;3036.3016506203253;3078.3227689908185;3108.518179682153;3111.9066428007195;3112.9533057004164;5501.202325662756;5504.449555044544;5513.8345849624575;5516.9448305516435;5519.116941289374;5998.280206375263;6002;6004.279486461653;6008;6012.789552365646;5515.7242137892945;5518.44815518453;5520.06158952979;5521.089020311684;5521.834344969658;5671.688057156896;5821.563382746226;5827.79602713903;5828.94171058301;5832.475077243069;5672.7730890763905;5679.488846003879;5683.033884239607;5688.374278829243;5691.914621280767;5488.725563721718;5491.2312276282155;5495.120780675073;5500.50495455411;5504.889902202013;3915.1582409780895;3968.523777146761;3979.263836190314;4025.778582177891;4028.254772867029;5823.854403639943;5832.358440571449;5835.970820146042;5838.649681019152;5839.5912286141265;5549.694766787866;5605.859853503695;5612.130119831432;5612.887742245214;5614.943850561442;5591.860203494945;5595.804146854841;5597.944020559742;5601.159826026129;5631.239782629293;5368.865778355573;5499.835004949858;5502.972485137549;5511.173324001432;5514.200440936122;5417.079096553516;5545.057340252086;5648.406917273627;5648.774049037993;5652.180433837153;5330.920036199383;5464.28964234647;5493.835184944458;5496.6701997880255;5501.5323697486165 05:16:23 INFO - 2015-12-18 05:16:23,760 DEBUG : BROWSER_OUTPUT: |5;yui.html;622.9470495007927;652.9118568993184;695.9039512767389;737.2038198745356;757.6476938223726;10767.2462927595;10899.237053406265;10918.890811091887;10923.508442120105;10938.56245750171;10634.57461701531;11275.210735248536;11387.658370248906;11411;12783.552575659854;790.3913986230599;798.3094623150962;804.4770898915693;804.891339669146;806.7983004248938;794.8012996750813;797.7766225456852;801.3188789528912;802.5585927739749;802.8273921106961;829.7427797382801;836.9372297077743;838.0404436919723;838.8532006898798;840.1262686805715;827.0943317067802;829.722043115557;830.2237408023517;830.2403300979627;831.0692024932055;613.6348872420903;616.8982117950533;618.1747367264707;618.3198481670172;618.7061145955635;10474.26680132391;10746.462676866126;10771;10785;10799.298045627009;10299.279050466395;10317.690469285933;10332.690019299358;10434.791304173874;10684.626038088707;8281.83436331276;8660.133986601353;8706.129387061306;8761.693340733107;8959.193672569434;3115.984420077908;3171.8414079295944;3219.3078488125166;3240.935181296361;3267.6242232143372;34841.12897177565;35137.64862351369;36182;37511.624883751356;38273.23453530941;8586.39895207342;8588.699395521127;8714.302855771522;8828.161324674145;8930.732078037669;15595.53213403577;15601.375944962074;15617.219139043002;15626.921865390601;15649.68700626004;6244.812655620339;6355.3644635537;6369.554131210771;6423.807285781434;6470;3502.8073455959657;3509.771864828778;3510.4032314506085;3570.589382221026;3587.2466781975554;2583.1604728463326;2608.765211131007;2610.0864697356155;2611.516869379171;2618.0836707152343;434.87171284471157;450.75884401844854;451.99548004519534;460.6199885094743;462.1796311546964;393.661451152009;417.8349551926972;447.72778150883744;551.2585572405188;561.1806762127259;6405.743770249231;6641.966790166115;6808.863822723518;6901.585904845725;6994.510384273154;445.256421775629;451.1878618486711;502.4498174498991;522.8117877564074;591.3377017740073;3355.6476569959805;3355.681210285019;3490.458978858281;3519.2433626770367;3570.8571657133944;46506;46811.76594117007;46993.295100573516;47199;47348;37178;37415.25169496595;37654.24691506154;37829.24341513209;37920;33422.49866252008;33724.1568960773;39209.215815684096;41285;41532.58467415408;7268.055152830098;7464.216257293123;7490.191178308134;7562.810929726801;7612.238776122565;29475;29489.410211795213;29935.251618708837;30076;30106.24734381658;34983.475247871815;35036.12409689778;35358;36288;37811.43282850814;8577.8713319299;9587.952060239653;9898.653547125816;10160.33957792741;10225.386476811118;9158.129977652112;9197.816043679222;9218.723438296862;9354.7292577291;9375.85936210971;9803.754906127404;9850.261230407605;10061.195104391485;10147.391156530632;10323.793524129625;9804.215662747105;9821.263405244777;9898.20814334837;9916.504174791376;10060.647877324258;10006.149477294512;10182.23633227496;10231.641892533726;10239.129673977497;10262.127719143957;8590.742277731679;8932.240759535513;9006.36955413141;9086.818263634557;9171.54142292896;8791.208791208823;8912.561650126836;8930.19628233462;8966.892700438875;8973.237274831452 05:16:23 INFO - 2015-12-18 05:16:23,760 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:16:23 INFO - 2015-12-18 05:16:23,760 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:16:23 INFO - 2015-12-18 05:16:23,760 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,954 05:16:23 INFO - 2015-12-18 05:16:23,760 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:16:23 INFO - 2015-12-18 05:16:23,761 DEBUG : BROWSER_OUTPUT: __startTimestamp1450444583751__endTimestamp 05:16:23 INFO - 2015-12-18 05:16:23,761 DEBUG : BROWSER_OUTPUT: 05:16:23 INFO - 2015-12-18 05:16:23,761 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:16:23 INFO - 2015-12-18 05:16:23,761 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:16:23 INFO - 2015-12-18 05:16:23,761 DEBUG : BROWSER_OUTPUT: 05:16:23 INFO - 2015-12-18 05:16:23,761 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4639.71 Median:4760.81 stddev:486.61 (10.2%) stddev-sans-first:460.97 05:16:23 INFO - 2015-12-18 05:16:23,761 DEBUG : BROWSER_OUTPUT: Values: 2597.5 2692.1 2695.7 2703.1 2719.7 4496.6 4644.3 4682.3 4691.6 4702.5 4612.3 4643.5 4713.4 4757.1 4760.8 4333.6 4347.4 4378.1 4399.4 4421.3 4441.6 4459.1 4482.3 4486.7 4511.0 4197.8 4213.5 4305.9 4312.0 4319.9 4344.5 4359.4 4369.0 4379.9 4400.6 4312.0 4344.1 4345.5 4360.8 4369.2 4467.3 4566.6 4581.6 4596.9 4687.0 5049.4 5061.2 5077.8 5095.5 5108.0 5072.0 5075.8 5083.9 5087.5 5127.5 4471.5 4571.5 4677.5 4691.7 4699.6 5060.3 5077.0 5193.2 5196.3 5205.4 4951.5 5002.2 5017.7 5025.1 5027.3 4783.8 4926.0 5105.7 5115.1 5136.0 4875.8 4907.5 4986.4 4988.6 4997.4 4910.0 4917.4 4920.3 4957.4 4980.4 3995.4 4133.3 4167.2 4180.8 4207.2 3609.5 3670.8 3676.0 3697.7 3716.2 4281.0 4294.3 4301.8 4303.6 4340.5 4852.6 4986.1 5006.9 5018.5 5054.3 4235.3 4267.6 4304.5 4306.7 4344.6 4461.0 4499.6 4504.8 4513.9 4550.3 4590.0 4714.6 4838.2 4851.4 4857.5 4922.4 4951.7 4993.1 5020.5 5064.4 4835.6 4837.0 4841.6 4845.4 4888.2 4741.5 4851.1 5053.7 5060.0 5094.5 4916.9 5019.5 5135.8 5141.1 5160.4 4911.0 4911.7 4916.8 4922.0 4963.2 4741.5 4880.0 4918.6 4927.4 4971.0 4714.8 4729.6 4768.1 4789.9 4802.8 4923.0 4936.6 4941.3 4941.7 4958.4 4618.7 4748.3 4823.4 4831.5 4831.8 05:16:23 INFO - 2015-12-18 05:16:23,761 DEBUG : BROWSER_OUTPUT: 05:16:23 INFO - 2015-12-18 05:16:23,762 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39252.58 Median:31674.02 stddev:62974.18 (198.8%) stddev-sans-first:63083.82 05:16:23 INFO - 2015-12-18 05:16:23,762 DEBUG : BROWSER_OUTPUT: Values: 558.7 566.4 570.4 580.8 581.2 27392.7 28123.0 28127.0 35895.8 36535.0 40749.0 41346.8 41376.6 41409.8 41467.4 7832.2 7938.2 8002.1 8007.9 8009.1 7030.3 7193.6 10242.5 10483.7 10488.3 10084.5 10239.7 10246.3 10247.1 10251.9 7179.9 7365.0 9984.6 10081.1 10099.1 7069.8 10246.0 10528.9 10529.3 10545.1 37504.0 37592.2 37688.4 37785.4 38014.0 2834.4 3569.1 3614.3 3616.0 3666.8 28561.7 28629.6 28658.4 28750.9 28964.6 3453.7 3457.3 3492.1 3614.3 3688.5 215885.0 218219.0 218535.0 218771.0 218899.0 44642.8 47620.8 47654.3 55414.7 56925.7 48286.0 48499.8 48602.8 48637.3 48699.8 12725.9 12861.9 12896.5 12903.2 12907.6 9553.4 9611.8 9635.7 9736.2 9738.9 18804.6 18942.1 18945.6 18965.7 19010.8 7175.5 7272.7 7375.1 7407.1 7451.7 841.5 866.6 893.1 902.8 996.9 24424.6 24674.2 24824.9 24851.9 24904.3 956.2 973.7 997.7 1015.4 1033.0 12423.6 12441.8 12564.7 12587.8 12768.6 266449.0 271417.0 271598.0 271902.0 271919.0 44168.3 44628.6 44673.0 44720.8 44795.3 1081.5 1137.4 1172.7 1253.3 1259.1 23059.4 23365.5 23750.8 23973.3 23998.0 33057.0 33315.3 33337.0 33399.7 35814.6 146284.0 245754.0 251831.0 252929.0 253021.0 25461.4 25993.2 26022.3 26022.9 26023.5 35282.5 35372.0 35428.8 35618.8 36265.3 30661.0 30879.5 30970.7 31394.0 34533.3 33141.8 33980.3 34159.1 34188.1 34283.1 30777.0 31589.8 31671.2 31676.8 31679.4 28245.3 28822.9 30229.0 31230.8 32729.0 22659.9 22848.9 22926.7 22966.7 23143.5 05:16:23 INFO - 2015-12-18 05:16:23,762 DEBUG : BROWSER_OUTPUT: 05:16:23 INFO - 2015-12-18 05:16:23,762 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25233.13 Median:24048.97 stddev:73934.17 (307.4%) stddev-sans-first:74117.93 05:16:23 INFO - 2015-12-18 05:16:23,762 DEBUG : BROWSER_OUTPUT: Values: 329.1 333.2 334.6 335.4 335.8 12600.9 12968.9 14937.0 15358.8 16027.8 8453.6 9179.4 9470.4 9934.7 10197.7 4410.6 4535.1 4537.2 4538.0 4538.5 3451.1 3551.4 4494.0 5015.5 5181.2 5094.9 5122.1 5145.9 5150.3 5153.8 5136.5 5292.8 5662.2 5662.2 5671.9 5012.4 5014.6 5015.5 5019.9 5024.2 18842.2 18940.9 19540.5 19577.2 19595.9 1755.7 1905.6 1907.6 1927.4 2003.2 8625.8 8698.7 8878.2 8912.0 8973.8 1661.8 1667.5 1687.7 1689.6 1733.3 48775.5 50025.7 50296.7 50631.0 51266.0 9542.7 9749.3 9952.0 9953.7 10074.8 12525.7 12590.6 12602.4 12613.7 12620.9 6882.3 6955.7 7005.3 7050.3 7061.8 6696.1 6704.5 6736.0 6754.5 6756.9 4194.7 4223.6 4232.1 4257.1 4257.7 1622.6 1661.0 1664.8 1685.2 1768.9 845.4 848.0 949.4 992.7 996.3 14541.5 14779.3 15391.9 15978.4 16062.8 765.7 858.4 867.2 906.7 911.8 8924.9 9151.5 9217.8 9380.7 9456.1 446033.0 448676.0 453542.0 454663.0 457178.0 72456.0 75757.2 76019.7 76749.2 76846.0 1088.2 1088.3 1100.9 1103.9 1108.2 14402.6 14582.9 14624.1 14778.3 14908.2 32159.5 32166.5 33029.7 35201.5 37487.0 43053.1 43458.2 43687.3 44532.8 45347.8 8577.7 8855.4 9326.6 9336.9 9352.2 16359.9 16414.1 16480.3 16523.5 16830.5 13739.1 13809.4 13871.2 14152.6 14169.5 13588.3 13800.2 13855.9 13971.2 14106.4 10914.9 13201.6 13817.9 14014.4 14279.5 8604.7 8636.9 8771.8 8798.6 8799.0 9261.7 13178.5 13335.2 13601.4 13824.2 05:16:23 INFO - 2015-12-18 05:16:23,762 DEBUG : BROWSER_OUTPUT: 05:16:23 INFO - 2015-12-18 05:16:23,762 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5056.48 Median:6346.75 stddev:2666.32 (42.0%) stddev-sans-first:2658.42 05:16:23 INFO - 2015-12-18 05:16:23,763 DEBUG : BROWSER_OUTPUT: Values: 1246.3 1386.2 1387.5 1652.1 1718.9 6075.3 6895.1 7064.9 7074.6 7082.9 7178.2 7350.7 7356.7 7362.1 7362.3 1769.4 1793.1 1804.9 2065.4 2102.7 2046.0 2090.9 2091.9 2092.1 2095.6 2055.7 2067.5 2075.1 2111.9 2113.6 2063.2 2072.5 2096.8 2100.5 2104.5 2104.1 2134.6 2135.3 2137.9 2138.2 7280.8 7327.4 7333.7 7363.2 7371.7 4192.7 4276.6 4279.6 4307.9 4309.0 2595.7 2682.2 2690.4 2705.8 2720.7 848.9 854.6 854.8 859.8 871.9 9906.8 9957.5 9963.4 9969.0 9977.7 3702.5 3767.2 3830.5 3835.8 3838.5 8556.0 8564.7 8645.0 8654.3 8654.6 4185.8 4187.6 4189.2 4197.0 4201.0 3795.0 3808.6 3817.8 3824.8 3860.9 3053.8 3112.4 3113.1 3456.3 3549.7 978.5 993.5 1096.9 1109.1 1112.5 879.5 901.1 972.6 1181.6 1182.1 6886.9 6937.9 6997.3 7003.6 7060.3 1038.2 1042.3 1053.0 1055.6 1074.7 5345.0 5429.2 5448.6 5475.8 5478.0 8330.6 8464.8 8483.2 8636.9 8732.7 8541.6 8542.1 8606.7 8611.2 8650.7 6492.7 6658.5 6696.5 6702.2 6722.4 7002.3 7027.0 7056.4 7057.8 7080.3 7875.8 7968.0 8010.9 8045.9 8060.8 8045.1 8127.3 8251.7 8265.4 8359.3 6261.7 6331.5 6390.1 6390.3 6401.7 6924.3 7020.1 7022.6 7032.4 7032.8 5540.5 6264.8 6600.7 6604.0 6777.1 6339.2 6354.3 6373.7 6405.5 6444.9 6542.4 6605.7 6621.2 6631.3 6631.4 5776.5 5800.8 5803.3 5805.4 5810.7 6124.9 6272.2 6272.5 6275.0 6279.2 05:16:23 INFO - 2015-12-18 05:16:23,763 DEBUG : BROWSER_OUTPUT: 05:16:23 INFO - 2015-12-18 05:16:23,763 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4630.83 Median:5230.67 stddev:1357.95 (26.0%) stddev-sans-first:1322.28 05:16:23 INFO - 2015-12-18 05:16:23,764 DEBUG : BROWSER_OUTPUT: Values: 299.8 300.2 304.6 305.4 307.9 5247.3 5260.0 5361.7 5365.3 5386.0 5218.6 5223.0 5238.3 5241.4 5248.2 3879.4 4115.1 4119.8 4120.8 4125.3 3999.3 4022.4 4060.6 4077.0 4082.7 4046.6 4084.1 4084.7 4091.0 4098.7 3852.6 3951.9 3980.7 4088.0 4097.7 3636.6 3652.6 3654.9 3655.5 3670.7 5033.4 5041.6 5052.3 5061.8 5064.5 4746.6 4752.2 4753.7 4755.1 4759.6 5424.7 5541.3 5550.5 5561.6 5579.8 3998.1 3998.5 3999.8 4001.1 4001.7 5761.9 5852.0 5853.0 5853.5 5854.9 4049.5 4064.2 4075.4 4076.6 4078.5 3705.8 3857.7 4134.4 4140.3 4143.9 4545.4 4566.3 4567.3 4574.8 4683.9 5571.8 5575.6 5581.1 5582.9 5591.5 1460.0 1475.6 1475.8 1476.2 1476.8 992.8 1003.9 1008.3 1022.9 1023.1 4854.0 4855.2 4859.7 4863.2 4864.2 5755.7 5763.3 5770.0 5773.6 5775.2 4815.0 4841.8 4850.5 4856.4 4859.2 3036.3 3078.3 3108.5 3111.9 3113.0 5501.2 5504.4 5513.8 5516.9 5519.1 5998.3 6002.0 6004.3 6008.0 6012.8 5515.7 5518.4 5520.1 5521.1 5521.8 5671.7 5821.6 5827.8 5828.9 5832.5 5672.8 5679.5 5683.0 5688.4 5691.9 5488.7 5491.2 5495.1 5500.5 5504.9 3915.2 3968.5 3979.3 4025.8 4028.3 5823.9 5832.4 5836.0 5838.6 5839.6 5549.7 5605.9 5612.1 5612.9 5614.9 5591.9 5595.8 5597.9 5601.2 5631.2 5368.9 5499.8 5503.0 5511.2 5514.2 5417.1 5545.1 5648.4 5648.8 5652.2 5330.9 5464.3 5493.8 5496.7 5501.5 05:16:23 INFO - 2015-12-18 05:16:23,764 DEBUG : BROWSER_OUTPUT: 05:16:23 INFO - 2015-12-18 05:16:23,764 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11316.77 Median:23484.09 stddev:12572.55 (53.5%) stddev-sans-first:12582.17 05:16:23 INFO - 2015-12-18 05:16:23,764 DEBUG : BROWSER_OUTPUT: Values: 622.9 652.9 695.9 737.2 757.6 10767.2 10899.2 10918.9 10923.5 10938.6 10634.6 11275.2 11387.7 11411.0 12783.6 790.4 798.3 804.5 804.9 806.8 794.8 797.8 801.3 802.6 802.8 829.7 836.9 838.0 838.9 840.1 827.1 829.7 830.2 830.2 831.1 613.6 616.9 618.2 618.3 618.7 10474.3 10746.5 10771.0 10785.0 10799.3 10299.3 10317.7 10332.7 10434.8 10684.6 8281.8 8660.1 8706.1 8761.7 8959.2 3116.0 3171.8 3219.3 3240.9 3267.6 34841.1 35137.6 36182.0 37511.6 38273.2 8586.4 8588.7 8714.3 8828.2 8930.7 15595.5 15601.4 15617.2 15626.9 15649.7 6244.8 6355.4 6369.6 6423.8 6470.0 3502.8 3509.8 3510.4 3570.6 3587.2 2583.2 2608.8 2610.1 2611.5 2618.1 434.9 450.8 452.0 460.6 462.2 393.7 417.8 447.7 551.3 561.2 6405.7 6642.0 6808.9 6901.6 6994.5 445.3 451.2 502.4 522.8 591.3 3355.6 3355.7 3490.5 3519.2 3570.9 46506.0 46811.8 46993.3 47199.0 47348.0 37178.0 37415.3 37654.2 37829.2 37920.0 33422.5 33724.2 39209.2 41285.0 41532.6 7268.1 7464.2 7490.2 7562.8 7612.2 29475.0 29489.4 29935.3 30076.0 30106.2 34983.5 35036.1 35358.0 36288.0 37811.4 8577.9 9588.0 9898.7 10160.3 10225.4 9158.1 9197.8 9218.7 9354.7 9375.9 9803.8 9850.3 10061.2 10147.4 10323.8 9804.2 9821.3 9898.2 9916.5 10060.6 10006.1 10182.2 10231.6 10239.1 10262.1 8590.7 8932.2 9006.4 9086.8 9171.5 8791.2 8912.6 8930.2 8966.9 8973.2 05:16:23 INFO - 2015-12-18 05:16:23,764 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:16:23 INFO - 2015-12-18 05:16:23,764 DEBUG : BROWSER_OUTPUT: 05:16:24 INFO - 2015-12-18 05:16:24,498 INFO : Browser exited with error code: 0 05:16:24 INFO - 2015-12-18 05:16:24,519 INFO : Completed test dromaeo_css (00:18:38) 05:16:24 INFO - 2015-12-18 05:16:24,519 INFO : Starting test kraken 05:16:24 INFO - 2015-12-18 05:16:24,519 DEBUG : operating with platform_type : linux_ 05:16:24 INFO - 2015-12-18 05:16:24,519 INFO : Initialising browser for kraken test... 05:16:24 INFO - 2015-12-18 05:16:24,526 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ZL0fU/profile http://localhost:37027/getInfo.html 05:16:28 INFO - 2015-12-18 05:16:28,650 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:16:28 INFO - 2015-12-18 05:16:28,650 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:16:28 INFO - 2015-12-18 05:16:28,650 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:16:28 INFO - 2015-12-18 05:16:28,650 DEBUG : BROWSER_OUTPUT: __metrics 05:16:28 INFO - 2015-12-18 05:16:28,738 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] 05:16:28 INFO - 2015-12-18 05:16:28,794 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] 05:16:30 INFO - 2015-12-18 05:16:30,046 INFO : Browser initialized. 05:16:30 INFO - 2015-12-18 05:16:30,046 INFO : Running cycle 1/1 for kraken test... 05:16:30 INFO - 2015-12-18 05:16:30,046 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ZL0fU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:16:41 INFO - 2015-12-18 05:16:41,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 149553152 05:16:41 INFO - 2015-12-18 05:16:41,990 DEBUG : BROWSER_OUTPUT: 05:16:44 INFO - 2015-12-18 05:16:44,576 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37027/tests/kraken/driver.html?testName=audio-beat-detection) 05:16:45 INFO - 2015-12-18 05:16:45,157 DEBUG : BROWSER_OUTPUT: RSS: Main: 185225216 05:16:45 INFO - 2015-12-18 05:16:45,158 DEBUG : BROWSER_OUTPUT: 05:16:47 INFO - 2015-12-18 05:16:47,955 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37027/tests/kraken/driver.html?testName=audio-dft) 05:16:48 INFO - 2015-12-18 05:16:48,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 173703168 05:16:48 INFO - 2015-12-18 05:16:48,537 DEBUG : BROWSER_OUTPUT: 05:16:51 INFO - 2015-12-18 05:16:51,496 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37027/tests/kraken/driver.html?testName=audio-fft) 05:16:52 INFO - 2015-12-18 05:16:52,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 162803712 05:16:52 INFO - 2015-12-18 05:16:52,062 DEBUG : BROWSER_OUTPUT: 05:16:54 INFO - 2015-12-18 05:16:54,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37027/tests/kraken/driver.html?testName=audio-oscillator) 05:16:54 INFO - 2015-12-18 05:16:54,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 161992704 05:16:54 INFO - 2015-12-18 05:16:54,695 DEBUG : BROWSER_OUTPUT: 05:16:56 INFO - 2015-12-18 05:16:56,969 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37027/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:16:57 INFO - 2015-12-18 05:16:57,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 165781504 05:16:57 INFO - 2015-12-18 05:16:57,530 DEBUG : BROWSER_OUTPUT: 05:17:00 INFO - 2015-12-18 05:17:00,541 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37027/tests/kraken/driver.html?testName=imaging-darkroom) 05:17:01 INFO - 2015-12-18 05:17:01,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 164364288 05:17:01 INFO - 2015-12-18 05:17:01,123 DEBUG : BROWSER_OUTPUT: 05:17:04 INFO - 2015-12-18 05:17:04,530 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37027/tests/kraken/driver.html?testName=imaging-desaturate) 05:17:05 INFO - 2015-12-18 05:17:05,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 165486592 05:17:05 INFO - 2015-12-18 05:17:05,112 DEBUG : BROWSER_OUTPUT: 05:17:07 INFO - 2015-12-18 05:17:07,955 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37027/tests/kraken/driver.html?testName=json-parse-financial) 05:17:08 INFO - 2015-12-18 05:17:08,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 165298176 05:17:08 INFO - 2015-12-18 05:17:08,536 DEBUG : BROWSER_OUTPUT: 05:17:10 INFO - 2015-12-18 05:17:10,326 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37027/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:17:10 INFO - 2015-12-18 05:17:10,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 174379008 05:17:10 INFO - 2015-12-18 05:17:10,887 DEBUG : BROWSER_OUTPUT: 05:17:12 INFO - 2015-12-18 05:17:12,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:17:13 INFO - 2015-12-18 05:17:13,362 DEBUG : BROWSER_OUTPUT: RSS: Main: 172756992 05:17:13 INFO - 2015-12-18 05:17:13,362 DEBUG : BROWSER_OUTPUT: 05:17:15 INFO - 2015-12-18 05:17:15,438 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:17:16 INFO - 2015-12-18 05:17:16,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 183218176 05:17:16 INFO - 2015-12-18 05:17:16,019 DEBUG : BROWSER_OUTPUT: 05:17:18 INFO - 2015-12-18 05:17:18,543 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:17:19 INFO - 2015-12-18 05:17:19,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 192143360 05:17:19 INFO - 2015-12-18 05:17:19,130 DEBUG : BROWSER_OUTPUT: 05:17:21 INFO - 2015-12-18 05:17:21,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:17:22 INFO - 2015-12-18 05:17:22,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 186892288 05:17:22 INFO - 2015-12-18 05:17:22,320 DEBUG : BROWSER_OUTPUT: 05:17:24 INFO - 2015-12-18 05:17:24,115 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37027/tests/kraken/driver.html?testName=ai-astar) 05:17:24 INFO - 2015-12-18 05:17:24,365 DEBUG : BROWSER_OUTPUT: RSS: Main: 246194176 05:17:24 INFO - 2015-12-18 05:17:24,365 DEBUG : BROWSER_OUTPUT: 05:17:24 INFO - 2015-12-18 05:17:24,366 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:17:24 INFO - 2015-12-18 05:17:24,366 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:17:24 INFO - 2015-12-18 05:17:24,367 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:17:24 INFO - 2015-12-18 05:17:24,367 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:17:24 INFO - 2015-12-18 05:17:24,367 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;113;107;112;113;112;102;112;113;104 05:17:24 INFO - 2015-12-18 05:17:24,368 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;168;140;156;176;136;153;157;136;177;137 05:17:24 INFO - 2015-12-18 05:17:24,368 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;160;162;165;160;161;162;163;163 05:17:24 INFO - 2015-12-18 05:17:24,368 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;81;90;72;75;72;101;89;71 05:17:24 INFO - 2015-12-18 05:17:24,368 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;137;93;95;94;140;103;95;128 05:17:24 INFO - 2015-12-18 05:17:24,369 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;109;109;109;109;109;111 05:17:24 INFO - 2015-12-18 05:17:24,369 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;146;146;147;147;146;147;147;147;146 05:17:24 INFO - 2015-12-18 05:17:24,369 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;94;95;96;95;95;95;95;95;94 05:17:24 INFO - 2015-12-18 05:17:24,369 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;72;72;73;72;73;73;85;70;70 05:17:24 INFO - 2015-12-18 05:17:24,370 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;69;68;69;69;69;68;74;69 05:17:24 INFO - 2015-12-18 05:17:24,370 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;83;82;83;82;82;83;84;83 05:17:24 INFO - 2015-12-18 05:17:24,370 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;127;120;117;120;127;127;127;120;127 05:17:24 INFO - 2015-12-18 05:17:24,370 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;137;147;148;157;134;150;159;149;141 05:17:24 INFO - 2015-12-18 05:17:24,370 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;72;71;70;71;70;70;71;71;70 05:17:24 INFO - 2015-12-18 05:17:24,370 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:17:24 INFO - 2015-12-18 05:17:24,370 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:17:24 INFO - 2015-12-18 05:17:24,371 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1001 05:17:24 INFO - 2015-12-18 05:17:24,371 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:17:24 INFO - 2015-12-18 05:17:24,372 DEBUG : BROWSER_OUTPUT: __startTimestamp1450444644365__endTimestamp 05:17:24 INFO - 2015-12-18 05:17:24,372 DEBUG : BROWSER_OUTPUT: 05:17:24 INFO - 2015-12-18 05:17:24,372 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:17:24 INFO - 2015-12-18 05:17:24,372 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:17:24 INFO - 2015-12-18 05:17:24,373 DEBUG : BROWSER_OUTPUT: 05:17:24 INFO - 2015-12-18 05:17:24,373 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.90 Median:112.00 stddev:4.07 (3.6%) stddev-sans-first:4.29 05:17:24 INFO - 2015-12-18 05:17:24,373 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 107.0 112.0 113.0 112.0 102.0 112.0 113.0 104.0 05:17:24 INFO - 2015-12-18 05:17:24,373 DEBUG : BROWSER_OUTPUT: 05:17:24 INFO - 2015-12-18 05:17:24,373 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:153.60 Median:156.50 stddev:16.17 (10.3%) stddev-sans-first:16.29 05:17:24 INFO - 2015-12-18 05:17:24,373 DEBUG : BROWSER_OUTPUT: Values: 168.0 140.0 156.0 176.0 136.0 153.0 157.0 136.0 177.0 137.0 05:17:24 INFO - 2015-12-18 05:17:24,373 DEBUG : BROWSER_OUTPUT: 05:17:24 INFO - 2015-12-18 05:17:24,374 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.64 (1.0%) stddev-sans-first:1.72 05:17:24 INFO - 2015-12-18 05:17:24,374 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 160.0 162.0 165.0 160.0 161.0 162.0 163.0 163.0 05:17:24 INFO - 2015-12-18 05:17:24,374 DEBUG : BROWSER_OUTPUT: 05:17:24 INFO - 2015-12-18 05:17:24,374 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.60 Median:74.00 stddev:10.37 (14.0%) stddev-sans-first:10.72 05:17:24 INFO - 2015-12-18 05:17:24,374 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 81.0 90.0 72.0 75.0 72.0 101.0 89.0 71.0 05:17:24 INFO - 2015-12-18 05:17:24,374 DEBUG : BROWSER_OUTPUT: 05:17:24 INFO - 2015-12-18 05:17:24,374 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.40 Median:94.00 stddev:19.47 (20.7%) stddev-sans-first:20.03 05:17:24 INFO - 2015-12-18 05:17:24,374 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 137.0 93.0 95.0 94.0 140.0 103.0 95.0 128.0 05:17:24 INFO - 2015-12-18 05:17:24,375 DEBUG : BROWSER_OUTPUT: 05:17:24 INFO - 2015-12-18 05:17:24,375 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 05:17:24 INFO - 2015-12-18 05:17:24,375 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 111.0 05:17:24 INFO - 2015-12-18 05:17:24,375 DEBUG : BROWSER_OUTPUT: 05:17:24 INFO - 2015-12-18 05:17:24,375 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.53 05:17:24 INFO - 2015-12-18 05:17:24,375 DEBUG : BROWSER_OUTPUT: Values: 149.0 146.0 146.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 05:17:24 INFO - 2015-12-18 05:17:24,376 DEBUG : BROWSER_OUTPUT: 05:17:24 INFO - 2015-12-18 05:17:24,376 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 05:17:24 INFO - 2015-12-18 05:17:24,376 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 94.0 05:17:24 INFO - 2015-12-18 05:17:24,376 DEBUG : BROWSER_OUTPUT: 05:17:24 INFO - 2015-12-18 05:17:24,378 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.40 Median:73.00 stddev:4.27 (5.9%) stddev-sans-first:4.53 05:17:24 INFO - 2015-12-18 05:17:24,378 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 72.0 73.0 72.0 73.0 73.0 85.0 70.0 70.0 05:17:24 INFO - 2015-12-18 05:17:24,378 DEBUG : BROWSER_OUTPUT: 05:17:24 INFO - 2015-12-18 05:17:24,378 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:1.79 (2.6%) stddev-sans-first:1.86 05:17:24 INFO - 2015-12-18 05:17:24,378 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 68.0 69.0 69.0 69.0 68.0 74.0 69.0 05:17:24 INFO - 2015-12-18 05:17:24,378 DEBUG : BROWSER_OUTPUT: 05:17:24 INFO - 2015-12-18 05:17:24,378 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:0.67 (0.8%) stddev-sans-first:0.67 05:17:24 INFO - 2015-12-18 05:17:24,378 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 83.0 82.0 83.0 82.0 82.0 83.0 84.0 83.0 05:17:24 INFO - 2015-12-18 05:17:24,378 DEBUG : BROWSER_OUTPUT: 05:17:24 INFO - 2015-12-18 05:17:24,379 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:127.00 stddev:4.09 (3.2%) stddev-sans-first:4.19 05:17:24 INFO - 2015-12-18 05:17:24,379 DEBUG : BROWSER_OUTPUT: Values: 127.0 127.0 120.0 117.0 120.0 127.0 127.0 127.0 120.0 127.0 05:17:24 INFO - 2015-12-18 05:17:24,379 DEBUG : BROWSER_OUTPUT: 05:17:24 INFO - 2015-12-18 05:17:24,379 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.30 Median:148.50 stddev:8.12 (5.5%) stddev-sans-first:8.39 05:17:24 INFO - 2015-12-18 05:17:24,379 DEBUG : BROWSER_OUTPUT: Values: 141.0 137.0 147.0 148.0 157.0 134.0 150.0 159.0 149.0 141.0 05:17:24 INFO - 2015-12-18 05:17:24,379 DEBUG : BROWSER_OUTPUT: 05:17:24 INFO - 2015-12-18 05:17:24,379 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:0.79 (1.1%) stddev-sans-first:0.71 05:17:24 INFO - 2015-12-18 05:17:24,379 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 71.0 70.0 71.0 70.0 70.0 71.0 71.0 70.0 05:17:24 INFO - 2015-12-18 05:17:24,379 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:17:24 INFO - 2015-12-18 05:17:24,379 DEBUG : BROWSER_OUTPUT: 05:17:25 INFO - 2015-12-18 05:17:25,246 INFO : Browser exited with error code: 0 05:17:25 INFO - 2015-12-18 05:17:25,297 INFO : Completed test kraken (00:01:00) 05:17:25 INFO - 2015-12-18 05:17:25,297 INFO : Starting test v8_7 05:17:25 INFO - 2015-12-18 05:17:25,297 DEBUG : operating with platform_type : linux_ 05:17:25 INFO - 2015-12-18 05:17:25,297 INFO : Initialising browser for v8_7 test... 05:17:25 INFO - 2015-12-18 05:17:25,303 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7qGrjH/profile http://localhost:37027/getInfo.html 05:17:29 INFO - 2015-12-18 05:17:29,662 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:17:29 INFO - 2015-12-18 05:17:29,663 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:17:29 INFO - 2015-12-18 05:17:29,663 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:17:29 INFO - 2015-12-18 05:17:29,663 DEBUG : BROWSER_OUTPUT: __metrics 05:17:29 INFO - 2015-12-18 05:17:29,739 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] 05:17:29 INFO - 2015-12-18 05:17:29,795 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] 05:17:31 INFO - 2015-12-18 05:17:31,074 INFO : Browser initialized. 05:17:31 INFO - 2015-12-18 05:17:31,075 INFO : Running cycle 1/1 for v8_7 test... 05:17:31 INFO - 2015-12-18 05:17:31,075 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7qGrjH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:17:43 INFO - 2015-12-18 05:17:43,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 150294528 05:17:43 INFO - 2015-12-18 05:17:43,005 DEBUG : BROWSER_OUTPUT: 05:18:04 INFO - 2015-12-18 05:18:04,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37027/tests/v8_7/run.html (next: http://localhost:37027/tests/v8_7/run.html) 05:18:04 INFO - 2015-12-18 05:18:04,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 450174976 05:18:04 INFO - 2015-12-18 05:18:04,666 DEBUG : BROWSER_OUTPUT: 05:18:04 INFO - 2015-12-18 05:18:04,666 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:18:04 INFO - 2015-12-18 05:18:04,666 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:18:04 INFO - 2015-12-18 05:18:04,666 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:18:04 INFO - 2015-12-18 05:18:04,666 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:18:04 INFO - 2015-12-18 05:18:04,666 DEBUG : BROWSER_OUTPUT: |0;Richards;166.03021749958492 05:18:04 INFO - 2015-12-18 05:18:04,666 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.8045336306206 05:18:04 INFO - 2015-12-18 05:18:04,666 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.08676307007784 05:18:04 INFO - 2015-12-18 05:18:04,666 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5122.448979591837 05:18:04 INFO - 2015-12-18 05:18:04,666 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1994.0239043824702 05:18:04 INFO - 2015-12-18 05:18:04,666 DEBUG : BROWSER_OUTPUT: |5;Earley;786.1635220125786 05:18:04 INFO - 2015-12-18 05:18:04,666 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 05:18:04 INFO - 2015-12-18 05:18:04,667 DEBUG : BROWSER_OUTPUT: |7;RegExp;26500 05:18:04 INFO - 2015-12-18 05:18:04,667 DEBUG : BROWSER_OUTPUT: |8;Splay;614.2506142506143 05:18:04 INFO - 2015-12-18 05:18:04,667 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 05:18:04 INFO - 2015-12-18 05:18:04,667 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:18:04 INFO - 2015-12-18 05:18:04,667 DEBUG : BROWSER_OUTPUT: __startTimestamp1450444684659__endTimestamp 05:18:04 INFO - 2015-12-18 05:18:04,667 DEBUG : BROWSER_OUTPUT: 05:18:04 INFO - 2015-12-18 05:18:04,667 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:18:04 INFO - 2015-12-18 05:18:04,667 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:18:04 INFO - 2015-12-18 05:18:04,667 DEBUG : BROWSER_OUTPUT: 05:18:04 INFO - 2015-12-18 05:18:04,667 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.03 Median:166.03 stddev:0.00 (0.0%) 05:18:04 INFO - 2015-12-18 05:18:04,667 DEBUG : BROWSER_OUTPUT: Values: 166.0 05:18:04 INFO - 2015-12-18 05:18:04,667 DEBUG : BROWSER_OUTPUT: 05:18:04 INFO - 2015-12-18 05:18:04,667 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.80 Median:185.80 stddev:0.00 (0.0%) 05:18:04 INFO - 2015-12-18 05:18:04,668 DEBUG : BROWSER_OUTPUT: Values: 185.8 05:18:04 INFO - 2015-12-18 05:18:04,668 DEBUG : BROWSER_OUTPUT: 05:18:04 INFO - 2015-12-18 05:18:04,668 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 05:18:04 INFO - 2015-12-18 05:18:04,668 DEBUG : BROWSER_OUTPUT: Values: 278.1 05:18:04 INFO - 2015-12-18 05:18:04,668 DEBUG : BROWSER_OUTPUT: 05:18:04 INFO - 2015-12-18 05:18:04,668 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5122.45 Median:5122.45 stddev:0.00 (0.0%) 05:18:04 INFO - 2015-12-18 05:18:04,668 DEBUG : BROWSER_OUTPUT: Values: 5122.4 05:18:04 INFO - 2015-12-18 05:18:04,668 DEBUG : BROWSER_OUTPUT: 05:18:04 INFO - 2015-12-18 05:18:04,668 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1994.02 Median:1994.02 stddev:0.00 (0.0%) 05:18:04 INFO - 2015-12-18 05:18:04,668 DEBUG : BROWSER_OUTPUT: Values: 1994.0 05:18:04 INFO - 2015-12-18 05:18:04,668 DEBUG : BROWSER_OUTPUT: 05:18:04 INFO - 2015-12-18 05:18:04,668 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:786.16 Median:786.16 stddev:0.00 (0.0%) 05:18:04 INFO - 2015-12-18 05:18:04,668 DEBUG : BROWSER_OUTPUT: Values: 786.2 05:18:04 INFO - 2015-12-18 05:18:04,669 DEBUG : BROWSER_OUTPUT: 05:18:04 INFO - 2015-12-18 05:18:04,669 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 05:18:04 INFO - 2015-12-18 05:18:04,669 DEBUG : BROWSER_OUTPUT: Values: 12207.3 05:18:04 INFO - 2015-12-18 05:18:04,669 DEBUG : BROWSER_OUTPUT: 05:18:04 INFO - 2015-12-18 05:18:04,669 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26500.00 Median:26500.00 stddev:0.00 (0.0%) 05:18:04 INFO - 2015-12-18 05:18:04,669 DEBUG : BROWSER_OUTPUT: Values: 26500.0 05:18:04 INFO - 2015-12-18 05:18:04,669 DEBUG : BROWSER_OUTPUT: 05:18:04 INFO - 2015-12-18 05:18:04,669 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:614.25 Median:614.25 stddev:0.00 (0.0%) 05:18:04 INFO - 2015-12-18 05:18:04,669 DEBUG : BROWSER_OUTPUT: Values: 614.3 05:18:04 INFO - 2015-12-18 05:18:04,669 DEBUG : BROWSER_OUTPUT: 05:18:04 INFO - 2015-12-18 05:18:04,669 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 05:18:04 INFO - 2015-12-18 05:18:04,669 DEBUG : BROWSER_OUTPUT: Values: 4854.4 05:18:04 INFO - 2015-12-18 05:18:04,669 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:18:04 INFO - 2015-12-18 05:18:04,669 DEBUG : BROWSER_OUTPUT: 05:18:05 INFO - 2015-12-18 05:18:05,538 INFO : Browser exited with error code: 0 05:18:05 INFO - 2015-12-18 05:18:05,555 INFO : Completed test v8_7 (00:00:40) 05:18:05 INFO - 2015-12-18 05:18:05,715 INFO : Completed test suite (00:20:19) 05:18:05 INFO - 2015-12-18 05:18:05,715 DEBUG : Working with test: dromaeo_css 05:18:05 INFO - 2015-12-18 05:18:05,715 DEBUG : Generating results file: dromaeo_css 05:18:05 INFO - 2015-12-18 05:18:05,716 DEBUG : Working with test: kraken 05:18:05 INFO - 2015-12-18 05:18:05,716 DEBUG : Generating results file: kraken 05:18:05 INFO - 2015-12-18 05:18:05,717 INFO : javascript benchmark 05:18:05 INFO - 2015-12-18 05:18:05,717 DEBUG : Working with test: v8_7 05:18:05 INFO - 2015-12-18 05:18:05,717 DEBUG : Generating results file: v8_7 05:18:05 INFO - 2015-12-18 05:18:05,717 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:18:05 INFO - 2015-12-18 05:18:05,794 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 05:18:05 INFO - 2015-12-18 05:18:05,795 DEBUG : process_Request line: dromaeo_css 6223.89 graph.html#tests=[[72,132,35]] 05:18:05 INFO - 2015-12-18 05:18:05,795 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:18:05 INFO - 2015-12-18 05:18:05,826 DEBUG : process_Request line: kraken 1529.40 graph.html#tests=[[232,132,35]] 05:18:05 INFO - 2015-12-18 05:18:05,826 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:18:05 INFO - 2015-12-18 05:18:05,866 DEBUG : process_Request line: v8_7 19822.79 graph.html#tests=[[230,132,35]] 05:18:05 INFO - 2015-12-18 05:18:05,868 INFO : javascript benchmark 05:18:05 INFO - 2015-12-18 05:18:05,871 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2597.5324441600515, 2692.0712354237808, 2695.7458695825694, 2703.0674417326027, 2719.673639163301, 4496.550344965502, 4644.256918892977, 4682.297655351699, 4691.648126390517, 4702.506236845129, 4612.285095810146, 4643.512431194727, 4713.434387873452, 4757.1437141314545, 4760.8095676173, 4333.609975102248, 4347.434833471644, 4378.058717375764, 4399.42807435033, 4421.292593185091, 4441.578050085237, 4459.130469558438, 4482.260427029552, 4486.730796152225, 4511.030128522367, 4197.8320867165585, 4213.47331583552, 4305.935410968838, 4312.0, 4319.935200971988, 4344.45694288214, 4359.38968544404, 4369.0, 4379.868603941887, 4400.647948164139, 4312.029793296515, 4344.066025804435, 4345.456817897762, 4360.825566977317, 4369.169857727054, 4467.285234362519, 4566.634669226454, 4581.5647513486165, 4596.862094137181, 4687.039156972813, 5049.394072711299, 5061.240813877911, 5077.822276220351, 5095.515925987025, 5108.029474399852, 5072.0, 5075.822346217865, 5083.87290317745, 5087.516685914832, 5127.512886275797, 4471.5081341052455, 4571.474280457724, 4677.4854765975715, 4691.718496890129, 4699.577038066591, 5060.2662613920775, 5077.035363280965, 5193.195054766517, 5196.32447781786, 5205.375354957429, 4951.529604687549, 5002.199648056367, 5017.7491125443585, 5025.14572522672, 5027.345184567563, 4783.832565860178, 4925.990172014728, 5105.7191854448365, 5115.130427827278, 5136.0, 4875.829345972874, 4907.509249075064, 4986.426560945465, 4988.55103040728, 4997.425296090923, 4910.017996400734, 4917.434495033117, 4920.286558449005, 4957.405111386584, 4980.377452818398, 3995.440638310639, 4133.338665813516, 4167.166566686675, 4180.770057646798, 4207.200631879933, 3609.4766258892314, 3670.7614005089586, 3676.0258531489176, 3697.685696715809, 3716.201016781405, 4280.978595107004, 4294.29144191205, 4301.849435269751, 4303.63419109373, 4340.52254252032, 4852.636052296092, 4986.052649996489, 5006.924896126561, 5018.4981501849525, 5054.317667114966, 4235.343521754133, 4267.573242675708, 4304.526502084768, 4306.676999225071, 4344.630706389992, 4461.040876211565, 4499.617532509707, 4504.8423305184815, 4513.887152821206, 4550.340200670884, 4590.0, 4714.622830173509, 4838.153323168502, 4851.393575803025, 4857.514248575114, 4922.433920099091, 4951.653384263067, 4993.076280888047, 5020.523050310215, 5064.41759197697, 4835.6131509479865, 4837.032593481388, 4841.612670986242, 4845.370101886732, 4888.2178851383605, 4741.525847415369, 4851.078295123915, 5053.69677819332, 5060.038592667382, 5094.541491265803, 4916.92624610624, 5019.472955339783, 5135.845924622267, 5141.100307446257, 5160.406553246425, 4911.0423467424935, 4911.68074075184, 4916.7541622919425, 4922.040202160544, 4963.181075122564, 4741.549552792617, 4879.95120048795, 4918.5573298403315, 4927.359443272351, 4970.975145124251, 4714.834980775657, 4729.55069268419, 4768.1417344878255, 4789.9042019160115, 4802.807887684454, 4922.975385123052, 4936.605071594192, 4941.308216849572, 4941.678790878582, 4958.380202474691, 4618.722876627278, 4748.3352330674425, 4823.3729615149805, 4831.541003604652, 4831.806727730851], "unit": "score", "name": "dojo.html", "value": 4609.3144311863925}, {"lowerIsBetter": false, "replicates": [558.7429782300142, 566.4024454200817, 570.3526497425422, 580.7909152705025, 581.226968132384, 27392.726072739293, 28123.015694450725, 28127.0, 35895.820520897425, 36535.0, 40749.0, 41346.7932660337, 41376.58623413765, 41409.792951035204, 41467.37798933018, 7832.216778322179, 7938.245866642688, 8002.079760827522, 8007.879881801778, 8009.078955920057, 7030.26182250864, 7193.568385896837, 10242.487875606228, 10483.737906552358, 10488.265821392506, 10084.546195421224, 10239.744006399826, 10246.333988290737, 10247.077763001329, 10251.897481025206, 7179.856402871966, 7364.96317518409, 9984.600615975352, 10081.092701656886, 10099.091081802673, 7069.823254418629, 10246.0, 10528.894711052868, 10529.262951593391, 10545.050945414949, 37504.0, 37592.24815503702, 37688.43467347965, 37785.43321850174, 38014.049648759, 2834.4472827798586, 3569.089882080079, 3614.2952124335766, 3616.0, 3666.7616604920595, 28561.71438285632, 28629.57055644167, 28658.426831463254, 28750.856245718845, 28964.565531517044, 3453.723702103826, 3457.3085382923514, 3492.14442461596, 3614.34941710492, 3688.483612294281, 215885.0, 218219.0, 218535.0, 218771.0, 218899.0, 44642.776786115865, 47620.7618961903, 47654.28518572224, 55414.72292638511, 56925.71537142371, 48286.0, 48499.75750121227, 48602.756986214845, 48637.270440943415, 48699.75650121726, 12725.93637031809, 12861.935690321488, 12896.484140634457, 12903.161294515827, 12907.612771616867, 9553.426794392359, 9611.807763844685, 9635.710928672152, 9736.172425343924, 9738.853917191247, 18804.623907522047, 18942.147603357884, 18945.621087578173, 18965.715514267296, 19010.80989190118, 7175.533590316612, 7272.709091636381, 7375.078115235596, 7407.111226621621, 7451.701931922662, 841.5119230846217, 866.5797088412115, 893.1425831201989, 902.8239493298744, 996.8903420623726, 24424.63363049556, 24674.162471316027, 24824.875875620506, 24851.875740621545, 24904.252872413857, 956.1872408452759, 973.7419583810296, 997.7079681812071, 1015.4364327797995, 1032.963846265377, 12423.565175219004, 12441.813372799415, 12564.685882852818, 12587.811182832265, 12768.553100641433, 266449.0, 271417.0, 271598.0, 271902.0, 271919.0, 44168.3374749379, 44628.55371446244, 44673.0, 44720.77639611781, 44795.32807007898, 1081.5133190064503, 1137.3858116616934, 1172.6540670502222, 1253.2678760302447, 1259.0745801835826, 23059.423514412272, 23365.53268934578, 23750.762492375547, 23973.28080157598, 23998.0, 33057.0, 33315.33369332648, 33337.0, 33399.666003339655, 35814.64185358113, 146284.0, 245754.0, 251831.0, 252929.0, 253021.0, 25461.3634659135, 25993.22020339393, 26022.34944126412, 26022.86988565045, 26023.479530408906, 35282.47076293909, 35372.0, 35428.822855885555, 35618.821905890305, 36265.27469450649, 30661.0, 30879.536806948363, 30970.690293097683, 31394.0, 34533.30933381368, 33141.83429082839, 33980.32039359149, 34159.14602134867, 34188.14529636779, 34283.142921426166, 30777.0, 31589.8420507896, 31671.20821979469, 31676.841615791775, 31679.36641267208, 28245.293867653472, 28822.855885720437, 30229.0, 31230.843845780626, 32728.951732218684, 22659.886700566392, 22848.88720030344, 22926.656100158845, 22966.655500167177, 23143.537129257656], "unit": "score", "name": "ext.html", "value": 16642.663388229517}, {"lowerIsBetter": false, "replicates": [329.14586647649344, 333.21029160888696, 334.6319049046048, 335.42394410924106, 335.7817418677859, 12600.873991260085, 12968.935155324234, 14937.0, 15358.846411535882, 16027.759583606241, 8453.577321133935, 9179.403338782991, 9470.431774093558, 9934.65228716995, 10197.745056373595, 4410.603045725884, 4535.070310586339, 4537.160625284317, 4537.954620453786, 4538.523455037223, 3451.050960985724, 3551.3785087609695, 4494.0, 5015.473375295596, 5181.1710126379785, 5094.949050509503, 5122.129238029525, 5145.897082058356, 5150.27896094547, 5153.793848246066, 5136.486351364871, 5292.814751483699, 5662.150677398382, 5662.235598194232, 5671.886562268773, 5012.373453318335, 5014.648974571782, 5015.523525265094, 5019.899602007976, 5024.196128619404, 18842.246310147577, 18940.90529547357, 19540.511487212792, 19577.21691132353, 19595.90202048995, 1755.6664233795539, 1905.637928793525, 1907.6280125375558, 1927.3928712455672, 2003.24878170686, 8625.784355391103, 8698.695545655872, 8878.179973105562, 8912.019677835433, 8973.820523589491, 1661.775660285858, 1667.4747454551778, 1687.7130887749113, 1689.5691598642268, 1733.340588564096, 48775.51224487745, 50025.74987125077, 50296.748516257554, 50631.0, 51266.0, 9542.666006689733, 9749.31754777173, 9951.950240248752, 9953.651622193333, 10074.798504029879, 12525.749485010248, 12590.622281331574, 12602.432890519949, 12613.684657883627, 12620.936895315464, 6882.277360877136, 6955.652217389212, 7005.334493223136, 7050.259722729143, 7061.788146355618, 6696.129503164558, 6704.530682852153, 6735.966320168368, 6754.493412994045, 6756.864862702817, 4194.727342722713, 4223.619874211275, 4232.090100628379, 4257.148570285955, 4257.723247988871, 1622.594351412147, 1661.036598772733, 1664.7669326294329, 1685.1826863970964, 1768.8761786675066, 845.3533047218882, 848.0332421040019, 949.3829011142813, 992.731962370156, 996.2528103922059, 14541.491047813275, 14779.26103694811, 15391.92304038495, 15978.440754573534, 16062.75905861413, 765.7358211417052, 858.4205661178679, 867.2108381372921, 906.7143849687327, 911.7583840282331, 8924.8661270081, 9151.496667683208, 9217.815643687089, 9380.671676491427, 9456.101670341306, 446033.0, 448676.0, 453542.0, 454663.0, 457178.0, 72456.0, 75757.24242757502, 76019.73733546011, 76749.23250767421, 76846.0, 1088.2327958789035, 1088.3469918049266, 1100.878903320634, 1103.9282446640943, 1108.2076315434342, 14402.639934001734, 14582.85417145815, 14624.120392948904, 14778.261086945395, 14908.18005009735, 32159.51760723638, 32166.51750223795, 33029.66970330266, 35201.47197792086, 37487.0, 43053.13893722171, 43458.2195958438, 43687.344689830315, 44532.77733611311, 45347.77326113348, 8577.699780507652, 8855.424397414148, 9326.626934922528, 9336.906630933603, 9352.205062569486, 16359.918200408922, 16414.09722465276, 16480.34078636841, 16523.50429487069, 16830.495085147464, 13739.106958047694, 13809.381535703535, 13871.167729936236, 14152.646183845487, 14169.504067357593, 13588.320583970959, 13800.171989680652, 13855.930720346334, 13971.231582263074, 14106.435742570182, 10914.890851091388, 13201.60395188146, 13817.930910345785, 14014.36935337892, 14279.500217492754, 8604.65581376763, 8636.913630863863, 8771.780705482413, 8798.604062817316, 8798.97623546575, 9261.67584134552, 13178.472861085449, 13335.199888006751, 13601.387937542637, 13824.239666818421], "unit": "score", "name": "jquery.html", "value": 8124.728796568572}, {"lowerIsBetter": false, "replicates": [1246.3082988941146, 1386.1960063163367, 1387.5282403982644, 1652.0748380906693, 1718.8710846686502, 6075.331713511516, 6895.10363652725, 7064.894026589605, 7074.610896400696, 7082.893756593642, 7178.210396856354, 7350.705971761136, 7356.705731770723, 7362.116546014472, 7362.337389634932, 1769.4249368955077, 1793.1124093573699, 1804.9097545122756, 2065.4320061983, 2102.7056212130315, 2045.9590808183827, 2090.9163633454646, 2091.947701307472, 2092.0899408757164, 2095.5704080663504, 2055.701923221132, 2067.503799088223, 2075.0765909170427, 2111.862728922615, 2113.598416300898, 2063.174730107969, 2072.492239401349, 2096.7693553709078, 2100.464381582702, 2104.547522282709, 2104.1478201328487, 2134.6157691615504, 2135.284679632325, 2137.9096660703, 2138.187488754279, 7280.8179795505, 7327.377172940306, 7333.669984850694, 7363.2268611795525, 7371.705131794722, 4192.664586833046, 4276.572342765729, 4279.572042795727, 4307.870763877088, 4309.0, 2595.662563866685, 2682.2355628645937, 2690.4350086481863, 2705.756481916637, 2720.659917510311, 848.944818586796, 854.6282367170301, 854.7606670132373, 859.7979474823411, 871.8605023196258, 9906.801863962752, 9957.5021248938, 9963.352382095212, 9969.003099690046, 9977.700668979942, 3702.5371828521434, 3767.171222331083, 3830.5020347354666, 3835.8082095895093, 3838.4626152338697, 8556.0, 8564.74305770828, 8645.049044605088, 8654.307655387554, 8654.567271636393, 4185.769782661982, 4187.6440502557625, 4189.2040512302565, 4197.013701780079, 4201.0, 3794.962050379516, 3808.6191380862247, 3817.7900215487857, 3824.8470061197795, 3860.942085868714, 3053.7862349635757, 3112.4086423579447, 3113.112762862573, 3456.3260164267726, 3549.6627820357025, 978.5351957820121, 993.5032483758121, 1096.8702236696215, 1109.1071687291808, 1112.5327362507767, 879.4503435352905, 901.121406628532, 972.5526257921435, 1181.5628217559558, 1182.148852825964, 6886.931130688729, 6937.895931561031, 6997.335253150943, 7003.5797852129035, 7060.3292687194635, 1038.200585549138, 1042.3329069395593, 1052.9947350263353, 1055.5988724284875, 1074.7152004718755, 5344.984452953926, 5429.239906413105, 5448.591355648342, 5475.808346707926, 5478.0, 8330.583470826556, 8464.830703385898, 8483.194096560817, 8636.913630863737, 8732.650693972297, 8541.615627296787, 8542.060373358925, 8606.65573377058, 8611.224989750952, 8650.74047778555, 6492.707828147651, 6658.4673226141795, 6696.531242813054, 6702.19573651165, 6722.361375669304, 7002.334778196063, 7027.0, 7056.400205982343, 7057.788266352018, 7080.2919708028785, 7875.842483150191, 7967.960160199162, 8010.879836802569, 8045.919540804517, 8060.838783224185, 8045.11503734577, 8127.3091787198755, 8251.669933202846, 8265.380096492667, 8359.289460395934, 6261.655608941552, 6331.461825744863, 6390.105385245976, 6390.297067322684, 6401.679916004088, 6924.272951340036, 7020.122484689414, 7022.6488675565, 7032.367086962198, 7032.753853615099, 5540.473655002768, 6264.812055638338, 6600.669966501559, 6604.0, 6777.051212830306, 6339.207599050119, 6354.301026886947, 6373.681315934277, 6405.487560995016, 6444.871102578016, 6542.378474044958, 6605.702743376463, 6621.172353455818, 6631.33686631333, 6631.370019848299, 5776.508996735324, 5800.8259752207505, 5803.303603567599, 5805.448482394166, 5810.680412577349, 6124.938750612437, 6272.18461599989, 6272.4982001440685, 6275.0, 6279.183706118175], "unit": "score", "name": "mootools.html", "value": 4123.328739822818}, {"lowerIsBetter": false, "replicates": [299.75270401918414, 300.1805072153023, 304.60401478078506, 305.4486651593872, 307.8860821496046, 5247.317848679671, 5260.0, 5361.705106219157, 5365.329333833266, 5385.973070134643, 5218.634695571312, 5223.0, 5238.345206849144, 5241.39723931747, 5248.239005344223, 3879.4180872869156, 4115.074108325633, 4119.752814831105, 4120.752754834704, 4125.319322311815, 3999.2601368746728, 4022.4368588397647, 4060.634542891139, 4076.9592304077023, 4082.6937979651498, 4046.5953404659595, 4084.121913788535, 4084.693647976399, 4091.0, 4098.7130900836955, 3852.595477474853, 3951.940720889189, 3980.7412518186516, 4087.9591204088024, 4097.73364731293, 3636.6181550937035, 3652.561692596879, 3654.872079477232, 3655.4882316475714, 3670.7063434925144, 5033.421156566968, 5041.59667226621, 5052.267421223902, 5061.772220250097, 5064.468230835746, 4746.644001699852, 4752.215884379073, 4753.714777113384, 4755.144074066667, 4759.643026772971, 5424.728763561806, 5541.27963364764, 5550.47270509301, 5561.610687251894, 5579.776808927638, 3998.140399814054, 3998.460207871929, 3999.8000099995174, 4001.139754952699, 4001.7198796083994, 5761.88476230473, 5852.034414321632, 5852.970735146339, 5853.531717462635, 5854.912176317359, 4049.4735684360844, 4064.207479541461, 4075.449814275094, 4076.613951256528, 4078.469798926121, 3705.7776533408082, 3857.6528112470014, 4134.359174327984, 4140.254754144283, 4143.917121657611, 4545.3863728396245, 4566.269396896547, 4567.269236922077, 4574.839880604163, 4683.882902927454, 5571.777128914798, 5575.581831362664, 5581.079121944834, 5582.944170558324, 5591.496765291144, 1459.9927000365142, 1475.6310922269433, 1475.8081449411509, 1476.195473466963, 1476.7858660494169, 992.846108853129, 1003.8895721470633, 1008.2740426892625, 1022.9335093219066, 1023.1150055202196, 4854.0, 4855.223164293767, 4859.684120532154, 4863.1732605457155, 4864.221724524059, 5755.712214389264, 5763.279590051244, 5769.9711501442225, 5773.566982476331, 5775.191473193756, 4815.012922350909, 4841.782119804618, 4850.466448690711, 4856.39295088114, 4859.246816743411, 3036.3016506203253, 3078.3227689908185, 3108.518179682153, 3111.9066428007195, 3112.9533057004164, 5501.202325662756, 5504.449555044544, 5513.8345849624575, 5516.9448305516435, 5519.116941289374, 5998.280206375263, 6002.0, 6004.279486461653, 6008.0, 6012.789552365646, 5515.7242137892945, 5518.44815518453, 5520.06158952979, 5521.089020311684, 5521.834344969658, 5671.688057156896, 5821.563382746226, 5827.79602713903, 5828.94171058301, 5832.475077243069, 5672.7730890763905, 5679.488846003879, 5683.033884239607, 5688.374278829243, 5691.914621280767, 5488.725563721718, 5491.2312276282155, 5495.120780675073, 5500.50495455411, 5504.889902202013, 3915.1582409780895, 3968.523777146761, 3979.263836190314, 4025.778582177891, 4028.254772867029, 5823.854403639943, 5832.358440571449, 5835.970820146042, 5838.649681019152, 5839.5912286141265, 5549.694766787866, 5605.859853503695, 5612.130119831432, 5612.887742245214, 5614.943850561442, 5591.860203494945, 5595.804146854841, 5597.944020559742, 5601.159826026129, 5631.239782629293, 5368.865778355573, 5499.835004949858, 5502.972485137549, 5511.173324001432, 5514.200440936122, 5417.079096553516, 5545.057340252086, 5648.406917273627, 5648.774049037993, 5652.180433837153, 5330.920036199383, 5464.28964234647, 5493.835184944458, 5496.6701997880255, 5501.5323697486165], "unit": "score", "name": "prototype.html", "value": 4198.558992868926}, {"lowerIsBetter": false, "replicates": [622.9470495007927, 652.9118568993184, 695.9039512767389, 737.2038198745356, 757.6476938223726, 10767.2462927595, 10899.237053406265, 10918.890811091887, 10923.508442120105, 10938.56245750171, 10634.57461701531, 11275.210735248536, 11387.658370248906, 11411.0, 12783.552575659854, 790.3913986230599, 798.3094623150962, 804.4770898915693, 804.891339669146, 806.7983004248938, 794.8012996750813, 797.7766225456852, 801.3188789528912, 802.5585927739749, 802.8273921106961, 829.7427797382801, 836.9372297077743, 838.0404436919723, 838.8532006898798, 840.1262686805715, 827.0943317067802, 829.722043115557, 830.2237408023517, 830.2403300979627, 831.0692024932055, 613.6348872420903, 616.8982117950533, 618.1747367264707, 618.3198481670172, 618.7061145955635, 10474.26680132391, 10746.462676866126, 10771.0, 10785.0, 10799.298045627009, 10299.279050466395, 10317.690469285933, 10332.690019299358, 10434.791304173874, 10684.626038088707, 8281.83436331276, 8660.133986601353, 8706.129387061306, 8761.693340733107, 8959.193672569434, 3115.984420077908, 3171.8414079295944, 3219.3078488125166, 3240.935181296361, 3267.6242232143372, 34841.12897177565, 35137.64862351369, 36182.0, 37511.624883751356, 38273.23453530941, 8586.39895207342, 8588.699395521127, 8714.302855771522, 8828.161324674145, 8930.732078037669, 15595.53213403577, 15601.375944962074, 15617.219139043002, 15626.921865390601, 15649.68700626004, 6244.812655620339, 6355.3644635537, 6369.554131210771, 6423.807285781434, 6470.0, 3502.8073455959657, 3509.771864828778, 3510.4032314506085, 3570.589382221026, 3587.2466781975554, 2583.1604728463326, 2608.765211131007, 2610.0864697356155, 2611.516869379171, 2618.0836707152343, 434.87171284471157, 450.75884401844854, 451.99548004519534, 460.6199885094743, 462.1796311546964, 393.661451152009, 417.8349551926972, 447.72778150883744, 551.2585572405188, 561.1806762127259, 6405.743770249231, 6641.966790166115, 6808.863822723518, 6901.585904845725, 6994.510384273154, 445.256421775629, 451.1878618486711, 502.4498174498991, 522.8117877564074, 591.3377017740073, 3355.6476569959805, 3355.681210285019, 3490.458978858281, 3519.2433626770367, 3570.8571657133944, 46506.0, 46811.76594117007, 46993.295100573516, 47199.0, 47348.0, 37178.0, 37415.25169496595, 37654.24691506154, 37829.24341513209, 37920.0, 33422.49866252008, 33724.1568960773, 39209.215815684096, 41285.0, 41532.58467415408, 7268.055152830098, 7464.216257293123, 7490.191178308134, 7562.810929726801, 7612.238776122565, 29475.0, 29489.410211795213, 29935.251618708837, 30076.0, 30106.24734381658, 34983.475247871815, 35036.12409689778, 35358.0, 36288.0, 37811.43282850814, 8577.8713319299, 9587.952060239653, 9898.653547125816, 10160.33957792741, 10225.386476811118, 9158.129977652112, 9197.816043679222, 9218.723438296862, 9354.7292577291, 9375.85936210971, 9803.754906127404, 9850.261230407605, 10061.195104391485, 10147.391156530632, 10323.793524129625, 9804.215662747105, 9821.263405244777, 9898.20814334837, 9916.504174791376, 10060.647877324258, 10006.149477294512, 10182.23633227496, 10231.641892533726, 10239.129673977497, 10262.127719143957, 8590.742277731679, 8932.240759535513, 9006.36955413141, 9086.818263634557, 9171.54142292896, 8791.208791208823, 8912.561650126836, 8930.19628233462, 8966.892700438875, 8973.237274831452], "unit": "score", "name": "yui.html", "value": 5386.546071390441}], "name": "dromaeo_css", "value": 6223.889193555515}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 107.0, 112.0, 113.0, 112.0, 102.0, 112.0, 113.0, 104.0], "unit": "score", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [168.0, 140.0, 156.0, 176.0, 136.0, 153.0, 157.0, 136.0, 177.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 153.6}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 162.0, 165.0, 160.0, 161.0, 162.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 81.0, 90.0, 72.0, 75.0, 72.0, 101.0, 89.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.6}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 137.0, 93.0, 95.0, 94.0, 140.0, 103.0, 95.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [149.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "unit": "score", "name": "imaging-desaturate", "value": 94.9}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 72.0, 73.0, 72.0, 73.0, 73.0, 85.0, 70.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 73.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 68.0, 69.0, 69.0, 69.0, 68.0, 74.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 83.0, 82.0, 83.0, 82.0, 82.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [127.0, 127.0, 120.0, 117.0, 120.0, 127.0, 127.0, 127.0, 120.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.9}, {"lowerIsBetter": true, "replicates": [141.0, 137.0, 147.0, 148.0, 157.0, 134.0, 150.0, 159.0, 149.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.3}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 70.0, 71.0, 70.0, 70.0, 71.0, 71.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.8}], "name": "kraken", "value": 1529.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.03021749958492], "unit": "score", "name": "Richards", "value": 212.62394600000007}, {"lowerIsBetter": false, "replicates": [185.8045336306206], "unit": "score", "name": "DeltaBlue", "value": 355.8470759999999}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5122.448979591837], "unit": "score", "name": "Decrypt", "value": 51.96362151394425}, {"lowerIsBetter": false, "replicates": [1994.0239043824702], "unit": "score", "name": "RayTrace", "value": 371.1033746253746}, {"lowerIsBetter": false, "replicates": [786.1635220125786], "unit": "score", "name": "Earley", "value": 847.7409359999999}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [26500.0], "unit": "score", "name": "RegExp", "value": 34.37679245283018}, {"lowerIsBetter": false, "replicates": [614.2506142506143], "unit": "score", "name": "Splay", "value": 132.66734799999998}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 19822.785449279712}]} 05:18:05 INFO - RETURN: dromaeo_css: 6223.89 05:18:05 INFO - RETURN: kraken: 1529.40 05:18:05 INFO - RETURN: v8_7: 19822.79 05:18:05 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19822.79"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1529.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6223.89"}}} 05:18:05 INFO - Return code: 0 05:18:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:18:06 INFO - # TBPL SUCCESS # 05:18:06 INFO - Running post-action listener: _resource_record_post_action 05:18:06 INFO - Running post-run listener: _resource_record_post_run 05:18:07 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 147456; Write bytes: 551542784; Read time: 48; Write time: 762264 05:18:07 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 234373120; Read time: 0; Write time: 456684 05:18:07 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 147456; Write bytes: 317169664; Read time: 48; Write time: 305580 05:18:07 INFO - Running post-run listener: _upload_blobber_files 05:18:07 INFO - Blob upload gear active. 05:18:07 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:18:07 INFO - Copying logs to upload dir... 05:18:07 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.277669 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-18 05:18:07.026341) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 05:18:07.029548) ========= 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=447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010089 build_url: 'https://queue.taskcluster.net/v1/task/JtNTPl7aRayZ9KiYiHx-Tw/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 05:18:07.081167) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 05:18:07.081492) ========= 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=447a3abc0420b6a47dd38cba000001bf-1450443415.942831-1107316508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 05:18:07.131105) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 05:18:07.131420) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 05:18:07.131706) ========= ========= Total master_lag: 0.22 =========