builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-022 starttime: 1470936799.65 results: success (0) buildid: 20160811083720 builduid: b3c6cb78963c488188d7073e30824951 revision: 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 10:33:19.653414) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 10:33:19.653909) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 10:33:19.654199) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 10:33:19.669093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 10:33:19.669455) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-11 10:33:20-- 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% 42.8M=0s 2016-08-11 10:33:20 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114658 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 10:33:19.797841) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 10:33:19.798147) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020718 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 10:33:19.847216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 10:33:19.847632) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 --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 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 --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=9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-11 10:33:20,296 truncating revision to first 12 chars 2016-08-11 10:33:20,296 Setting DEBUG logging. 2016-08-11 10:33:20,296 attempt 1/10 2016-08-11 10:33:20,296 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9dae91a2c31d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 10:33:20,605 unpacking tar archive at: fx-team-9dae91a2c31d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.731091 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 10:33:20.592841) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 10:33:20.593233) ========= script_repo_revision: 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 10:33:20.593646) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 10:33:20.593909) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 10:33:20.603147) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-11 10:33:20.603503) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --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', '--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=9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:33:21 INFO - MultiFileLogger online at 20160811 10:33:21 in /builds/slave/test 10:33:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:33:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:33:21 INFO - {'append_to_log': False, 10:33:21 INFO - 'base_work_dir': '/builds/slave/test', 10:33:21 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:33:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:33:21 INFO - 'branch': 'Fx-Team-Non-PGO', 10:33:21 INFO - 'buildbot_json_path': 'buildprops.json', 10:33:21 INFO - 'config_files': ('talos/linux_config.py',), 10:33:21 INFO - 'default_actions': ('clobber', 10:33:21 INFO - 'read-buildbot-config', 10:33:21 INFO - 'download-and-extract', 10:33:21 INFO - 'populate-webroot', 10:33:21 INFO - 'create-virtualenv', 10:33:21 INFO - 'install', 10:33:21 INFO - 'run-tests'), 10:33:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:33:21 INFO - 'download_minidump_stackwalk': True, 10:33:21 INFO - 'download_symbols': 'ondemand', 10:33:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:33:21 INFO - 'tooltool.py': '/tools/tooltool.py', 10:33:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:33:21 INFO - '/tools/misc-python/virtualenv.py')}, 10:33:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:33:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:33:21 INFO - 'installer_path': 'installer.exe', 10:33:21 INFO - 'log_level': 'info', 10:33:21 INFO - 'log_name': 'talos', 10:33:21 INFO - 'log_to_console': True, 10:33:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:33:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:33:21 INFO - 'opt_config_files': (), 10:33:21 INFO - 'pip_index': False, 10:33:21 INFO - 'sps_profile': False, 10:33:21 INFO - 'sps_profile_interval': 0, 10:33:21 INFO - 'suite': 'dromaeojs', 10:33:21 INFO - 'system_bits': '32', 10:33:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:33:21 INFO - 'title': 'talos-linux64-ix-022', 10:33:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:33:21 INFO - 'use_talos_json': True, 10:33:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:33:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:33:21 INFO - 'work_dir': 'build'} 10:33:21 INFO - [mozharness: 2016-08-11 17:33:21.141530Z] Running clobber step. 10:33:21 INFO - Running pre-action listener: _resource_record_pre_action 10:33:21 INFO - Running main action method: clobber 10:33:21 INFO - rmtree: /builds/slave/test/build 10:33:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:33:21 INFO - Running post-action listener: _resource_record_post_action 10:33:21 INFO - [mozharness: 2016-08-11 17:33:21.646359Z] Finished clobber step (success) 10:33:21 INFO - [mozharness: 2016-08-11 17:33:21.646459Z] Running read-buildbot-config step. 10:33:21 INFO - Running pre-action listener: _resource_record_pre_action 10:33:21 INFO - Running main action method: read_buildbot_config 10:33:21 INFO - Using buildbot properties: 10:33:21 INFO - { 10:33:21 INFO - "project": "", 10:33:21 INFO - "product": "firefox", 10:33:21 INFO - "script_repo_revision": "production", 10:33:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:33:21 INFO - "repository": "", 10:33:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:33:21 INFO - "buildid": "20160811083720", 10:33:21 INFO - "pgo_build": "False", 10:33:21 INFO - "basedir": "/builds/slave/test", 10:33:21 INFO - "buildnumber": 3228, 10:33:21 INFO - "slavename": "talos-linux64-ix-022", 10:33:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:33:21 INFO - "platform": "ubuntu64_hw", 10:33:21 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 10:33:21 INFO - "branch": "fx-team", 10:33:21 INFO - "repo_path": "integration/fx-team", 10:33:21 INFO - "revision": "9dae91a2c31d1d7ee1f426b4f61179a42e0dab64", 10:33:21 INFO - "stage_platform": "linux64", 10:33:21 INFO - "builduid": "b3c6cb78963c488188d7073e30824951", 10:33:21 INFO - "slavebuilddir": "test" 10:33:21 INFO - } 10:33:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:33:21 INFO - Running post-action listener: _resource_record_post_action 10:33:21 INFO - [mozharness: 2016-08-11 17:33:21.648854Z] Finished read-buildbot-config step (success) 10:33:21 INFO - [mozharness: 2016-08-11 17:33:21.648940Z] Running download-and-extract step. 10:33:21 INFO - Running pre-action listener: _resource_record_pre_action 10:33:21 INFO - Running main action method: download_and_extract 10:33:21 INFO - mkdir: /builds/slave/test/build/tests 10:33:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:21 INFO - trying https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:33:21 INFO - Downloading https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:33:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:33:22 INFO - Downloaded 1361 bytes. 10:33:22 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:33:22 INFO - Using the following test package requirements: 10:33:22 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:33:22 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:33:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:33:22 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:33:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:33:22 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:33:22 INFO - u'jsshell-linux-x86_64.zip'], 10:33:22 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:33:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:33:22 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:33:22 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:33:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:33:22 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:33:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:33:22 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:33:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:33:22 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:33:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:33:22 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:33:22 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:22 INFO - trying https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:33:22 INFO - Downloading https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:33:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:33:23 INFO - Downloaded 20262322 bytes. 10:33:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:33:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:33:24 INFO - Return code: 0 10:33:24 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:33:24 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:24 INFO - trying https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:33:24 INFO - Downloading https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:33:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:33:25 INFO - Downloaded 20262322 bytes. 10:33:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:33:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:33:26 INFO - Return code: 0 10:33: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:26 INFO - trying https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:33:26 INFO - Downloading https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:33:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:33:27 INFO - Downloaded 14413719 bytes. 10:33:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:33:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:33:27 INFO - Return code: 0 10:33:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:27 INFO - trying https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:33:27 INFO - Downloading https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:33:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:33:29 INFO - Downloaded 55620196 bytes. 10:33:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:33:29 INFO - mkdir: /builds/slave/test/properties 10:33:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:33:29 INFO - Writing to file /builds/slave/test/properties/build_url 10:33:29 INFO - Contents: 10:33:29 INFO - build_url:https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:33:29 INFO - Running post-action listener: _resource_record_post_action 10:33:29 INFO - Running post-action listener: set_extra_try_arguments 10:33:29 INFO - [mozharness: 2016-08-11 17:33:29.991008Z] Finished download-and-extract step (success) 10:33:29 INFO - [mozharness: 2016-08-11 17:33:29.991240Z] Running populate-webroot step. 10:33:29 INFO - Running pre-action listener: _resource_record_pre_action 10:33:29 INFO - Running main action method: populate_webroot 10:33:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:33:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:33:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:33:30 INFO - '--tppagecycles', 10:33:30 INFO - '7'], 10:33:30 INFO - 'tests': ['tsvgm']}}, 10:33:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:33:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:33:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:33:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:33:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:33:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:33:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:30 INFO - 'talos_options': ['--disable-e10s'], 10:33:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:33:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:33:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:30 INFO - 'talos_options': ['--disable-e10s'], 10:33:30 INFO - 'tests': ['damp', 'tps']}, 10:33:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:30 INFO - 'tests': ['damp', 'tps']}, 10:33:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:33:30 INFO - 'tests': ['dromaeo_dom']}, 10:33:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:33:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:33:30 INFO - 'tests': ['basic_compositor_video']}, 10:33:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:33:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:33:30 INFO - 'tests': ['a11yr', 10:33:30 INFO - 'ts_paint', 10:33:30 INFO - 'tpaint', 10:33:30 INFO - 'sessionrestore', 10:33:30 INFO - 'sessionrestore_no_auto_restore', 10:33:30 INFO - 'tabpaint']}, 10:33:30 INFO - 'other-e10s': {'tests': ['a11yr', 10:33:30 INFO - 'ts_paint', 10:33:30 INFO - 'tpaint', 10:33:30 INFO - 'sessionrestore', 10:33:30 INFO - 'sessionrestore_no_auto_restore', 10:33:30 INFO - 'tabpaint']}, 10:33:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:33:30 INFO - 'ts_paint', 10:33:30 INFO - 'tpaint', 10:33:30 INFO - 'sessionrestore', 10:33:30 INFO - 'sessionrestore_no_auto_restore', 10:33:30 INFO - 'tabpaint']}, 10:33:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:33:30 INFO - 'ts_paint', 10:33:30 INFO - 'tpaint', 10:33:30 INFO - 'sessionrestore', 10:33:30 INFO - 'sessionrestore_no_auto_restore', 10:33:30 INFO - 'tabpaint']}, 10:33:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:33:30 INFO - 'tests': ['a11yr', 10:33:30 INFO - 'ts_paint', 10:33:30 INFO - 'tpaint', 10:33:30 INFO - 'sessionrestore', 10:33:30 INFO - 'sessionrestore_no_auto_restore', 10:33:30 INFO - 'tabpaint']}, 10:33:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:33:30 INFO - 'tests': ['a11yr', 10:33:30 INFO - 'ts_paint', 10:33:30 INFO - 'tpaint', 10:33:30 INFO - 'sessionrestore', 10:33:30 INFO - 'sessionrestore_no_auto_restore', 10:33:30 INFO - 'tabpaint']}, 10:33:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:33:30 INFO - 'tests': ['tsvgx', 10:33:30 INFO - 'tsvgr_opacity', 10:33:30 INFO - 'tart', 10:33:30 INFO - 'tscrollx', 10:33:30 INFO - 'cart']}, 10:33:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:33:30 INFO - 'tsvgr_opacity', 10:33:30 INFO - 'tart', 10:33:30 INFO - 'tscrollx', 10:33:30 INFO - 'cart']}, 10:33:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:30 INFO - 'talos_options': ['--disable-e10s'], 10:33:30 INFO - 'tests': ['tp5o']}, 10:33:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:30 INFO - 'tests': ['tp5o']}, 10:33:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:30 INFO - 'talos_options': ['--disable-e10s', 10:33:30 INFO - '--xperf_path', 10:33:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:33:30 INFO - 'tests': ['tp5n']}, 10:33:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:30 INFO - 'talos_options': ['--xperf_path', 10:33:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:33:30 INFO - 'tests': ['tp5n']}}, 10:33:30 INFO - 'talos.zip': {'path': '', 10:33:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:33:30 INFO - Running post-action listener: _resource_record_post_action 10:33:30 INFO - [mozharness: 2016-08-11 17:33:30.013230Z] Finished populate-webroot step (success) 10:33:30 INFO - [mozharness: 2016-08-11 17:33:30.013329Z] Running create-virtualenv step. 10:33:30 INFO - Running pre-action listener: _resource_record_pre_action 10:33:30 INFO - Running main action method: create_virtualenv 10:33:30 INFO - Creating virtualenv /builds/slave/test/build/venv 10:33:30 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 10:33:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:33:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:33:30 INFO - Using real prefix '/usr' 10:33:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:33:30 INFO - Installing distribute.............................................................................................................................................................................................done. 10:33:32 INFO - Installing pip.................done. 10:33:32 INFO - Return code: 0 10:33:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x249b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x275c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275a3b0>, '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 0x275b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275b740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085', '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 10:33:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 10:33:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 10:33:32 INFO - Using env: {'DISPLAY': ':0', 10:33:32 INFO - 'HOME': '/home/cltbld', 10:33:32 INFO - 'LANG': 'en_US.UTF-8', 10:33:32 INFO - 'LANGUAGE': 'en_US:en', 10:33:32 INFO - 'LOGNAME': 'cltbld', 10:33:32 INFO - 'MAIL': '/var/mail/cltbld', 10:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:32 INFO - 'MOZ_NO_REMOTE': '1', 10:33:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:32 INFO - 'NO_EM_RESTART': '1', 10:33:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:32 INFO - 'PWD': '/builds/slave/test', 10:33:32 INFO - 'SHELL': '/bin/bash', 10:33:32 INFO - 'SHLVL': '1', 10:33:32 INFO - 'TERM': 'linux', 10:33:32 INFO - 'TMOUT': '86400', 10:33:32 INFO - 'USER': 'cltbld', 10:33:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085', 10:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:32 INFO - '_': '/tools/buildbot/bin/python'} 10:33:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:32 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 10:33:32 INFO - Cleaning up... 10:33:32 INFO - Return code: 0 10:33:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x275c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275a3b0>, '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 0x275b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275b740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085', '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 10:33:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 10:33:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 10:33:32 INFO - Using env: {'DISPLAY': ':0', 10:33:32 INFO - 'HOME': '/home/cltbld', 10:33:32 INFO - 'LANG': 'en_US.UTF-8', 10:33:32 INFO - 'LANGUAGE': 'en_US:en', 10:33:32 INFO - 'LOGNAME': 'cltbld', 10:33:32 INFO - 'MAIL': '/var/mail/cltbld', 10:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:32 INFO - 'MOZ_NO_REMOTE': '1', 10:33:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:32 INFO - 'NO_EM_RESTART': '1', 10:33:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:32 INFO - 'PWD': '/builds/slave/test', 10:33:32 INFO - 'SHELL': '/bin/bash', 10:33:32 INFO - 'SHLVL': '1', 10:33:32 INFO - 'TERM': 'linux', 10:33:32 INFO - 'TMOUT': '86400', 10:33:32 INFO - 'USER': 'cltbld', 10:33:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085', 10:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:32 INFO - '_': '/tools/buildbot/bin/python'} 10:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:33 INFO - Downloading/unpacking psutil>=3.1.1 10:33:33 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 10:33:33 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 10:33:33 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 10:33:33 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 10:33:33 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 10:33:33 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 10:33:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:33:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:33:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:33:35 INFO - Installing collected packages: psutil 10:33:35 INFO - Running setup.py install for psutil 10:33:35 INFO - building 'psutil._psutil_linux' extension 10:33:35 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 10:33:35 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 10:33:35 INFO - building 'psutil._psutil_posix' extension 10:33:35 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 10:33:35 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 10:33:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:33:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:33:35 INFO - Successfully installed psutil 10:33:35 INFO - Cleaning up... 10:33:35 INFO - Return code: 0 10:33:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x275c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275a3b0>, '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 0x275b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275b740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085', '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 10:33:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 10:33:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 10:33:35 INFO - Using env: {'DISPLAY': ':0', 10:33:35 INFO - 'HOME': '/home/cltbld', 10:33:35 INFO - 'LANG': 'en_US.UTF-8', 10:33:35 INFO - 'LANGUAGE': 'en_US:en', 10:33:35 INFO - 'LOGNAME': 'cltbld', 10:33:35 INFO - 'MAIL': '/var/mail/cltbld', 10:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:35 INFO - 'MOZ_NO_REMOTE': '1', 10:33:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:35 INFO - 'NO_EM_RESTART': '1', 10:33:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:35 INFO - 'PWD': '/builds/slave/test', 10:33:35 INFO - 'SHELL': '/bin/bash', 10:33:35 INFO - 'SHLVL': '1', 10:33:35 INFO - 'TERM': 'linux', 10:33:35 INFO - 'TMOUT': '86400', 10:33:35 INFO - 'USER': 'cltbld', 10:33:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085', 10:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:35 INFO - '_': '/tools/buildbot/bin/python'} 10:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:33:35 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 10:33:35 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 10:33:35 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 10:33:35 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 10:33:35 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 10:33:35 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 10:33:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:33:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:33:37 INFO - Installing collected packages: mozsystemmonitor 10:33:37 INFO - Running setup.py install for mozsystemmonitor 10:33:37 INFO - Successfully installed mozsystemmonitor 10:33:37 INFO - Cleaning up... 10:33:37 INFO - Return code: 0 10:33:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x275c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275a3b0>, '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 0x275b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275b740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085', '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 10:33:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1'] in /builds/slave/test/build 10:33:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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==2.5.1 10:33:37 INFO - Using env: {'DISPLAY': ':0', 10:33:37 INFO - 'HOME': '/home/cltbld', 10:33:37 INFO - 'LANG': 'en_US.UTF-8', 10:33:37 INFO - 'LANGUAGE': 'en_US:en', 10:33:37 INFO - 'LOGNAME': 'cltbld', 10:33:37 INFO - 'MAIL': '/var/mail/cltbld', 10:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:37 INFO - 'MOZ_NO_REMOTE': '1', 10:33:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:37 INFO - 'NO_EM_RESTART': '1', 10:33:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:37 INFO - 'PWD': '/builds/slave/test', 10:33:37 INFO - 'SHELL': '/bin/bash', 10:33:37 INFO - 'SHLVL': '1', 10:33:37 INFO - 'TERM': 'linux', 10:33:37 INFO - 'TMOUT': '86400', 10:33:37 INFO - 'USER': 'cltbld', 10:33:37 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085', 10:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:37 INFO - '_': '/tools/buildbot/bin/python'} 10:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:38 INFO - Downloading/unpacking jsonschema==2.5.1 10:33:38 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 10:33:38 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 10:33:38 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 10:33:38 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 10:33:38 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 10:33:38 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 10:33:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:33:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:40 INFO - Downloading functools32-3.2.3-2.tar.gz 10:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:33:40 INFO - warning: no files found matching '*.txt' 10:33:40 INFO - no previously-included directories found matching 'build' 10:33:40 INFO - no previously-included directories found matching 'dist' 10:33:40 INFO - no previously-included directories found matching '.git*' 10:33:40 INFO - Installing collected packages: jsonschema, functools32 10:33:40 INFO - Running setup.py install for functools32 10:33:40 INFO - warning: no files found matching '*.txt' 10:33:40 INFO - no previously-included directories found matching 'build' 10:33:40 INFO - no previously-included directories found matching 'dist' 10:33:40 INFO - no previously-included directories found matching '.git*' 10:33:40 INFO - Successfully installed jsonschema functools32 10:33:40 INFO - Cleaning up... 10:33:40 INFO - Return code: 0 10:33:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x275c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275a3b0>, '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 0x275b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275b740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085', '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 10:33:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:33:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 functools32==3.2.3-2 10:33:40 INFO - Using env: {'DISPLAY': ':0', 10:33:40 INFO - 'HOME': '/home/cltbld', 10:33:40 INFO - 'LANG': 'en_US.UTF-8', 10:33:40 INFO - 'LANGUAGE': 'en_US:en', 10:33:40 INFO - 'LOGNAME': 'cltbld', 10:33:40 INFO - 'MAIL': '/var/mail/cltbld', 10:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:40 INFO - 'MOZ_NO_REMOTE': '1', 10:33:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:40 INFO - 'NO_EM_RESTART': '1', 10:33:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:40 INFO - 'PWD': '/builds/slave/test', 10:33:40 INFO - 'SHELL': '/bin/bash', 10:33:40 INFO - 'SHLVL': '1', 10:33:40 INFO - 'TERM': 'linux', 10:33:40 INFO - 'TMOUT': '86400', 10:33:40 INFO - 'USER': 'cltbld', 10:33:40 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085', 10:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:40 INFO - '_': '/tools/buildbot/bin/python'} 10:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:33:40 INFO - Cleaning up... 10:33:40 INFO - Return code: 0 10:33:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x249b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x275c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275a3b0>, '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 0x275b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275b740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085', '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 10:33:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 10:33:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 10:33:40 INFO - Using env: {'DISPLAY': ':0', 10:33:40 INFO - 'HOME': '/home/cltbld', 10:33:40 INFO - 'LANG': 'en_US.UTF-8', 10:33:40 INFO - 'LANGUAGE': 'en_US:en', 10:33:40 INFO - 'LOGNAME': 'cltbld', 10:33:40 INFO - 'MAIL': '/var/mail/cltbld', 10:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:40 INFO - 'MOZ_NO_REMOTE': '1', 10:33:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:40 INFO - 'NO_EM_RESTART': '1', 10:33:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:40 INFO - 'PWD': '/builds/slave/test', 10:33:40 INFO - 'SHELL': '/bin/bash', 10:33:40 INFO - 'SHLVL': '1', 10:33:40 INFO - 'TERM': 'linux', 10:33:40 INFO - 'TMOUT': '86400', 10:33:40 INFO - 'USER': 'cltbld', 10:33:40 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085', 10:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:40 INFO - '_': '/tools/buildbot/bin/python'} 10:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:40 INFO - Downloading/unpacking blobuploader==1.2.4 10:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:42 INFO - Downloading blobuploader-1.2.4.tar.gz 10:33:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:33:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:33:42 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 10:33:42 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 10:33:42 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 10:33:42 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 10:33:42 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 10:33:42 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 10:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:33:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:43 INFO - Downloading docopt-0.6.1.tar.gz 10:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:33:43 INFO - Installing collected packages: blobuploader, requests, docopt 10:33:43 INFO - Running setup.py install for blobuploader 10:33:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:33:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:33:43 INFO - Running setup.py install for requests 10:33:44 INFO - Running setup.py install for docopt 10:33:44 INFO - Successfully installed blobuploader requests docopt 10:33:44 INFO - Cleaning up... 10:33:44 INFO - Return code: 0 10:33:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x249b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x275c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275a3b0>, '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 0x275b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275b740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085', '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 10:33:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 10:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 10:33:44 INFO - Using env: {'DISPLAY': ':0', 10:33:44 INFO - 'HOME': '/home/cltbld', 10:33:44 INFO - 'LANG': 'en_US.UTF-8', 10:33:44 INFO - 'LANGUAGE': 'en_US:en', 10:33:44 INFO - 'LOGNAME': 'cltbld', 10:33:44 INFO - 'MAIL': '/var/mail/cltbld', 10:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:44 INFO - 'MOZ_NO_REMOTE': '1', 10:33:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:44 INFO - 'NO_EM_RESTART': '1', 10:33:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:44 INFO - 'PWD': '/builds/slave/test', 10:33:44 INFO - 'SHELL': '/bin/bash', 10:33:44 INFO - 'SHLVL': '1', 10:33:44 INFO - 'TERM': 'linux', 10:33:44 INFO - 'TMOUT': '86400', 10:33:44 INFO - 'USER': 'cltbld', 10:33:44 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085', 10:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:44 INFO - '_': '/tools/buildbot/bin/python'} 10:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:33:44 INFO - Running setup.py (path:/tmp/pip-IpC0Yk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:33:44 INFO - Running setup.py (path:/tmp/pip-3iQAgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:33:44 INFO - Running setup.py (path:/tmp/pip-5JRgSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:33:44 INFO - Running setup.py (path:/tmp/pip-c2BNei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:33:44 INFO - Running setup.py (path:/tmp/pip-fie3R4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:33:44 INFO - Running setup.py (path:/tmp/pip-zGGae1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:33:44 INFO - Running setup.py (path:/tmp/pip-vk035x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:33:44 INFO - Running setup.py (path:/tmp/pip-LNfTHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:33:44 INFO - Running setup.py (path:/tmp/pip-bvao15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:33:45 INFO - Running setup.py (path:/tmp/pip-SZDcbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:33:45 INFO - Running setup.py (path:/tmp/pip-w_0ZoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:33:45 INFO - Running setup.py (path:/tmp/pip-B3PAZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:33:45 INFO - Running setup.py (path:/tmp/pip-tn_AqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:33:45 INFO - Running setup.py (path:/tmp/pip-iGp3us-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:45 INFO - Running setup.py (path:/tmp/pip-FbRUfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:33:45 INFO - Running setup.py (path:/tmp/pip-eA2nG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:33:45 INFO - Running setup.py (path:/tmp/pip-3oACBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:33:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:33:45 INFO - Running setup.py install for manifestparser 10:33:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:33:45 INFO - Running setup.py install for mozcrash 10:33:45 INFO - Running setup.py install for mozdebug 10:33:45 INFO - Running setup.py install for mozdevice 10:33:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:33:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:33:46 INFO - Running setup.py install for mozfile 10:33:46 INFO - Running setup.py install for mozhttpd 10:33:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:33:46 INFO - Running setup.py install for mozinfo 10:33:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:33:46 INFO - Running setup.py install for mozInstall 10:33:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:33:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:33:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:33:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:33:46 INFO - Running setup.py install for mozleak 10:33:46 INFO - Running setup.py install for mozlog 10:33:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:33:46 INFO - Running setup.py install for moznetwork 10:33:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:33:46 INFO - Running setup.py install for mozprocess 10:33:46 INFO - Running setup.py install for mozprofile 10:33:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:33:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:33:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:33:46 INFO - Running setup.py install for mozrunner 10:33:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:33:47 INFO - Running setup.py install for mozscreenshot 10:33:47 INFO - Running setup.py install for moztest 10:33:47 INFO - Running setup.py install for mozversion 10:33:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:33:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:33:47 INFO - Cleaning up... 10:33:47 INFO - Return code: 0 10:33:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:33:47 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:47 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x249b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x275c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275a3b0>, '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 0x275b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275b740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085', '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 10:33:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 10:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 10:33:47 INFO - Using env: {'DISPLAY': ':0', 10:33:47 INFO - 'HOME': '/home/cltbld', 10:33:47 INFO - 'LANG': 'en_US.UTF-8', 10:33:47 INFO - 'LANGUAGE': 'en_US:en', 10:33:47 INFO - 'LOGNAME': 'cltbld', 10:33:47 INFO - 'MAIL': '/var/mail/cltbld', 10:33:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:47 INFO - 'MOZ_NO_REMOTE': '1', 10:33:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:47 INFO - 'NO_EM_RESTART': '1', 10:33:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:47 INFO - 'PWD': '/builds/slave/test', 10:33:47 INFO - 'SHELL': '/bin/bash', 10:33:47 INFO - 'SHLVL': '1', 10:33:47 INFO - 'TERM': 'linux', 10:33:47 INFO - 'TMOUT': '86400', 10:33:47 INFO - 'USER': 'cltbld', 10:33:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085', 10:33:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:47 INFO - '_': '/tools/buildbot/bin/python'} 10:33:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:33:47 INFO - Running setup.py (path:/tmp/pip-xQtzY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:33:47 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)) 10:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:33:47 INFO - Running setup.py (path:/tmp/pip-yfTDhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:33:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 10:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:33:47 INFO - Running setup.py (path:/tmp/pip-nnaMhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:33:47 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)) 10:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:33:47 INFO - Running setup.py (path:/tmp/pip-4CIXJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:33:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 10:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:33:47 INFO - Running setup.py (path:/tmp/pip-4bdgL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:33:48 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)) 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:33:48 INFO - Running setup.py (path:/tmp/pip-0PbVsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:33:48 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)) 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:33:48 INFO - Running setup.py (path:/tmp/pip-a4SOfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:33:48 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)) 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:33:48 INFO - Running setup.py (path:/tmp/pip-WBPDrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:33:48 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)) 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:33:48 INFO - Running setup.py (path:/tmp/pip-r9HhID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:33:48 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)) 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:33:48 INFO - Running setup.py (path:/tmp/pip-efkhaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:33:48 INFO - Running setup.py (path:/tmp/pip-mkVFuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:33:48 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)) 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:33:48 INFO - Running setup.py (path:/tmp/pip-6tRw87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:33:48 INFO - Running setup.py (path:/tmp/pip-YpMUPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:33:48 INFO - Running setup.py (path:/tmp/pip-2kgEVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:48 INFO - Running setup.py (path:/tmp/pip-rrY1gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:48 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)) 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:33:48 INFO - Running setup.py (path:/tmp/pip-kSUSTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:33:48 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)) 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:33:48 INFO - Running setup.py (path:/tmp/pip-ukL2eH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:33:48 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)) 10:33:48 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:33:48 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:33:48 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)) 10:33:48 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:33:48 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:33:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:33:48 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 10:33:48 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 10:33:48 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 10:33:48 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 10:33:48 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 10:33:48 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 10:33:50 INFO - Downloading blessings-1.6.tar.gz 10:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:33:50 INFO - Installing collected packages: blessings 10:33:50 INFO - Running setup.py install for blessings 10:33:50 INFO - Successfully installed blessings 10:33:50 INFO - Cleaning up... 10:33:51 INFO - Return code: 0 10:33:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:33:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:33:51 INFO - Reading from file tmpfile_stdout 10:33:51 INFO - Current package versions: 10:33:51 INFO - argparse == 1.2.1 10:33:51 INFO - blessings == 1.6 10:33:51 INFO - blobuploader == 1.2.4 10:33:51 INFO - docopt == 0.6.1 10:33:51 INFO - functools32 == 3.2.3-2 10:33:51 INFO - jsonschema == 2.5.1 10:33:51 INFO - manifestparser == 1.1 10:33:51 INFO - mozInstall == 1.12 10:33:51 INFO - mozcrash == 0.17 10:33:51 INFO - mozdebug == 0.1 10:33:51 INFO - mozdevice == 0.48 10:33:51 INFO - mozfile == 1.2 10:33:51 INFO - mozhttpd == 0.7 10:33:51 INFO - mozinfo == 0.9 10:33:51 INFO - mozleak == 0.1 10:33:51 INFO - mozlog == 3.3 10:33:51 INFO - moznetwork == 0.27 10:33:51 INFO - mozprocess == 0.23 10:33:51 INFO - mozprofile == 0.28 10:33:51 INFO - mozrunner == 6.12 10:33:51 INFO - mozscreenshot == 0.1 10:33:51 INFO - mozsystemmonitor == 0.3 10:33:51 INFO - moztest == 0.7 10:33:51 INFO - mozversion == 1.4 10:33:51 INFO - psutil == 3.1.1 10:33:51 INFO - requests == 1.2.3 10:33:51 INFO - wsgiref == 0.1.2 10:33:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x249b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x275c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275a3b0>, '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 0x275b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275b740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085', '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 10:33:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 10:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 10:33:51 INFO - Using env: {'DISPLAY': ':0', 10:33:51 INFO - 'HOME': '/home/cltbld', 10:33:51 INFO - 'LANG': 'en_US.UTF-8', 10:33:51 INFO - 'LANGUAGE': 'en_US:en', 10:33:51 INFO - 'LOGNAME': 'cltbld', 10:33:51 INFO - 'MAIL': '/var/mail/cltbld', 10:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:51 INFO - 'MOZ_NO_REMOTE': '1', 10:33:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:51 INFO - 'NO_EM_RESTART': '1', 10:33:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:51 INFO - 'PWD': '/builds/slave/test', 10:33:51 INFO - 'SHELL': '/bin/bash', 10:33:51 INFO - 'SHLVL': '1', 10:33:51 INFO - 'TERM': 'linux', 10:33:51 INFO - 'TMOUT': '86400', 10:33:51 INFO - 'USER': 'cltbld', 10:33:51 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085', 10:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:51 INFO - '_': '/tools/buildbot/bin/python'} 10:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:33:51 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 2)) 10:33:51 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 3)) 10:33:51 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 4)) 10:33:51 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 5)) 10:33:51 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 6)) 10:33:51 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 7)) 10:33:51 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 8)) 10:33:51 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 9)) 10:33:51 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:33:51 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 4)) 10:33:51 INFO - Cleaning up... 10:33:51 INFO - Return code: 0 10:33:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x249b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x275c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275a3b0>, '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 0x275b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275b740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085', '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 10:33:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 10:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 10:33:51 INFO - Using env: {'DISPLAY': ':0', 10:33:51 INFO - 'HOME': '/home/cltbld', 10:33:51 INFO - 'LANG': 'en_US.UTF-8', 10:33:51 INFO - 'LANGUAGE': 'en_US:en', 10:33:51 INFO - 'LOGNAME': 'cltbld', 10:33:51 INFO - 'MAIL': '/var/mail/cltbld', 10:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:51 INFO - 'MOZ_NO_REMOTE': '1', 10:33:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:51 INFO - 'NO_EM_RESTART': '1', 10:33:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:51 INFO - 'PWD': '/builds/slave/test', 10:33:51 INFO - 'SHELL': '/bin/bash', 10:33:51 INFO - 'SHLVL': '1', 10:33:51 INFO - 'TERM': 'linux', 10:33:51 INFO - 'TMOUT': '86400', 10:33:51 INFO - 'USER': 'cltbld', 10:33:51 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085', 10:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:51 INFO - '_': '/tools/buildbot/bin/python'} 10:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:33:51 INFO - Cleaning up... 10:33:51 INFO - Return code: 0 10:33:51 INFO - Running post-action listener: _resource_record_post_action 10:33:51 INFO - Running post-action listener: _start_resource_monitoring 10:33:51 INFO - Starting resource monitoring. 10:33:51 INFO - [mozharness: 2016-08-11 17:33:51.705900Z] Finished create-virtualenv step (success) 10:33:51 INFO - [mozharness: 2016-08-11 17:33:51.706375Z] Running install step. 10:33:51 INFO - Running pre-action listener: _resource_record_pre_action 10:33:51 INFO - Running main action method: install 10:33:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:33:51 INFO - Reading from file tmpfile_stdout 10:33:51 INFO - Detecting whether we're running mozinstall >=1.0... 10:33:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:33:51 INFO - Reading from file tmpfile_stdout 10:33:51 INFO - Output received: 10:33:51 INFO - Usage: mozinstall [options] installer 10:33:51 INFO - Options: 10:33:51 INFO - -h, --help show this help message and exit 10:33:51 INFO - -d DEST, --destination=DEST 10:33:51 INFO - Directory to install application into. [default: 10:33:51 INFO - "/builds/slave/test"] 10:33:51 INFO - --app=APP Application being installed. [default: firefox] 10:33:51 INFO - mkdir: /builds/slave/test/build/application 10:33:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:34:08 INFO - Reading from file tmpfile_stdout 10:34:08 INFO - Output received: 10:34:08 INFO - /builds/slave/test/build/application/firefox/firefox 10:34:08 INFO - Running post-action listener: _resource_record_post_action 10:34:08 INFO - [mozharness: 2016-08-11 17:34:08.066447Z] Finished install step (success) 10:34:08 INFO - [mozharness: 2016-08-11 17:34:08.066693Z] Running run-tests step. 10:34:08 INFO - Running pre-action listener: _resource_record_pre_action 10:34:08 INFO - Running main action method: run_tests 10:34:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:34:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:34:08 INFO - Python 2.7.3 10:34:08 INFO - Return code: 0 10:34:08 INFO - grabbing minidump binary from tooltool 10:34: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:08 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275a3b0>, '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 0x275b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:34:08 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 10:34:08 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 10:34:08 INFO - Calling ['/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'] with output_timeout 600 10:34:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:34:08 INFO - Return code: 0 10:34:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:34:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:34:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:34:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:34:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:34:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:34:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:34:08 INFO - Using env: {'DISPLAY': ':0', 10:34:08 INFO - 'HOME': '/home/cltbld', 10:34:08 INFO - 'LANG': 'en_US.UTF-8', 10:34:08 INFO - 'LANGUAGE': 'en_US:en', 10:34:08 INFO - 'LOGNAME': 'cltbld', 10:34:08 INFO - 'MAIL': '/var/mail/cltbld', 10:34:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:34:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:34:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:08 INFO - 'MOZ_NO_REMOTE': '1', 10:34:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:34:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:08 INFO - 'NO_EM_RESTART': '1', 10:34:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:08 INFO - 'PWD': '/builds/slave/test', 10:34:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:34:08 INFO - 'SHELL': '/bin/bash', 10:34:08 INFO - 'SHLVL': '1', 10:34:08 INFO - 'TERM': 'linux', 10:34:08 INFO - 'TMOUT': '86400', 10:34:08 INFO - 'USER': 'cltbld', 10:34:08 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085', 10:34:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:08 INFO - '_': '/tools/buildbot/bin/python'} 10:34:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:34:08 INFO - mozversion application_buildid: 20160811083720 10:34:08 INFO - mozversion application_changeset: 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 10:34:08 INFO - mozversion application_display_name: Nightly 10:34:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:34:08 INFO - mozversion application_name: Firefox 10:34:08 INFO - mozversion application_remotingname: firefox 10:34:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:34:08 INFO - mozversion application_vendor: Mozilla 10:34:08 INFO - mozversion application_version: 51.0a1 10:34:08 INFO - mozversion platform_buildid: 20160811083720 10:34:08 INFO - mozversion platform_changeset: 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 10:34:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:34:08 INFO - mozversion platform_version: 51.0a1 10:34:08 INFO - using testdate: 1470936848 10:34:08 INFO - actual date: 1470936848 10:34:08 INFO - starting webserver on 'localhost:53002' 10:34:08 INFO - SUITE-START | Running 2 tests 10:34:08 INFO - TEST-START | dromaeo_css 10:34:08 INFO - operating with platform_type : linux_ 10:34:08 INFO - Initialising browser for dromaeo_css test... 10:34:08 INFO - TEST-INFO | started process 29933 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpanHiTy/profile http://localhost:53002/getInfo.html) 10:34:12 INFO - PROCESS | 29933 | __metrics Screen width/height:1600/1200 10:34:12 INFO - PROCESS | 29933 | colorDepth:24 10:34:12 INFO - PROCESS | 29933 | Browser inner width/height: 1024/697 10:34:12 INFO - PROCESS | 29933 | __metrics 10:34:13 INFO - PROCESS | 29933 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:34:13 INFO - PROCESS | 29933 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:34:13 INFO - PROCESS | 29933 | console.error: PushService: 10:34:13 INFO - PROCESS | 29933 | stateChangeProcessEnqueue: Error transitioning state 10:34:13 INFO - PROCESS | 29933 | UnknownError 10:34:14 INFO - TEST-INFO | 29933: exit 0 10:34:14 INFO - Browser initialized. 10:34:14 INFO - Running cycle 1/1 for dromaeo_css test... 10:34:14 INFO - TEST-INFO | started process 30014 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpanHiTy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:34:26 INFO - PROCESS | 30014 | RSS: Main: 157204480 10:34:26 INFO - PROCESS | 30014 | 10:35:17 INFO - PROCESS | 30014 | 1470936917420 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:37:30 INFO - PROCESS | 30014 | Cycle 1(1): loaded http://localhost:53002/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53002/tests/dromaeo/cssquery-ext.html) 10:37:31 INFO - PROCESS | 30014 | RSS: Main: 238391296 10:37:31 INFO - PROCESS | 30014 | 10:40:34 INFO - PROCESS | 30014 | Cycle 1(1): loaded http://localhost:53002/tests/dromaeo/cssquery-ext.html (next: http://localhost:53002/tests/dromaeo/cssquery-jquery.html) 10:40:34 INFO - PROCESS | 30014 | RSS: Main: 246255616 10:40:34 INFO - PROCESS | 30014 | 10:43:36 INFO - PROCESS | 30014 | Cycle 1(1): loaded http://localhost:53002/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53002/tests/dromaeo/cssquery-mootools.html) 10:43:37 INFO - PROCESS | 30014 | RSS: Main: 251809792 10:43:37 INFO - PROCESS | 30014 | 10:46:39 INFO - PROCESS | 30014 | Cycle 1(1): loaded http://localhost:53002/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53002/tests/dromaeo/cssquery-prototype.html) 10:46:40 INFO - PROCESS | 30014 | RSS: Main: 189054976 10:46:40 INFO - PROCESS | 30014 | 10:49:43 INFO - PROCESS | 30014 | Cycle 1(1): loaded http://localhost:53002/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53002/tests/dromaeo/cssquery-yui.html) 10:49:44 INFO - PROCESS | 30014 | RSS: Main: 190414848 10:49:44 INFO - PROCESS | 30014 | 10:52:46 INFO - PROCESS | 30014 | Cycle 1(1): loaded http://localhost:53002/tests/dromaeo/cssquery-yui.html (next: http://localhost:53002/tests/dromaeo/cssquery-dojo.html) 10:52:47 INFO - PROCESS | 30014 | RSS: Main: 280825856 10:52:47 INFO - PROCESS | 30014 | 10:52:47 INFO - PROCESS | 30014 | __start_tp_report 10:52:47 INFO - PROCESS | 30014 | _x_x_mozilla_page_load 10:52:47 INFO - PROCESS | 30014 | _x_x_mozilla_page_load_details 10:52:47 INFO - PROCESS | 30014 | |i|pagename|runs| 10:52:47 INFO - PROCESS | 30014 | |0;dojo.html;2650.297671117154;2665.5735082386823;2684.3020814588203;2696.87864046118;2701.459708058389;4663.347131401598;4709;4775.665703400759;4928.5564299213065;4944.530269624389;4743;4816.157172494817;4832.420109586846;4845.152098382778;4865.124277630025;4377.212101821671;4381.715188512752;4399.098184872094;4409.82360705573;4586.1974154522995;4498.8875278117985;4539.727616343013;4553.795079221443;4576.06190730901;4576.267797152456;4282.635975942048;4479.059397526524;4480.865574032784;4529.275315949432;4551.476580193271;4313.913721725579;4400.317950717644;4417.955820441786;4441.045175287329;4454.35411865281;4389.780510974439;4392.516823149451;4429.6013358797545;4440.489343725449;4446.066326071529;4850.296706977504;4854.563089321978;4887.0714564232685;4890.339804126468;4903.117438861003;4937.950620493785;5108.540231379194;5138.203578445347;5161;5242.580593552507;5200.401953775288;5239.1093514102695;5262.894742105136;5271.789128434858;5274.393444753826;4638;4903.950960490385;4915.852524424273;4916.778744956486;4919.237518184687;5228.529432351107;5290.709011004432;5291.444398338119;5297.125974214211;5361.571074314045;5106.540411362995;5144;5151.845444636667;5153.149730294459;5156.407013193456;4944.085344211332;5188.818391356284;5189.584833213409;5195.454477279907;5228.05894938907;5053.36832895888;5111.105556527667;5111.846644600668;5180.093483640348;5180.404253510895;5100.770465329069;5105.9489405106215;5116.334876466036;5116.795328186905;5117.948820511747;4340.52254252032;4342.717723347972;4345.674074444366;4378.365137055109;4390.385346051556;3665.633436656313;3666.6883314917995;3744.756590821588;3768.9811550942068;3810.0665336992615;4432.3794668746405;4436.733795972252;4472.329150627367;4476.888077798081;4479.216137175981;5060.696358218519;5109.3613298337705;5120.078385890575;5128.8461346159675;5179.300794392784;4270.7864606769535;4427.136708341843;4434.3348497724955;4475.4181956345465;4482.977585112054;4654.953450465519;4656.4412270527755;4677.812887484531;4679.508651591602;4695.389599352063;4917.827876024322;4925.926111108336;4928.162212423968;4932.901341973212;4976.0794253063295;4963.553280204799;5131.127708289525;5210.947890521046;5219.034478621467;5277.656952298088;4892.755362231803;4932.802687892444;4933.506649335038;4978.775955081957;4982.775775090057;5110.948890511196;5126.487351264844;5131.153359695758;5133.204353325241;5184.0927837629015;4931.112399767932;5094.286799848099;5199.142141546602;5216.165413533817;5217.895642087061;4977.477364876636;5019.472955339636;5024.522670346311;5069.290299358019;5071.974640126776;4999.8750031248055;5002;5002.949970500248;5004.499550045112;5053.216751403538;4709.8116075357975;4825.4933232011535;4879.829205977774;4943.505649435027;4984.900301993867;4949.6287778416045;4985.775640096277;4994.225894986283;5026.547610715053;5046.571041461517;4882.584980276574;4884.047610716018;4884.731339776205;4891.168501354707;4940 10:52:47 INFO - PROCESS | 30014 | |1;ext.html;554.5203399059814;580.5645765675746;580.7909152705029;593.9465448109669;597.6682940967761;37438.25123497529;38977.22045559087;39051.41422878659;39056.60943390565;43327;40514;40934.18131637365;40981.180376392454;41061.58938410615;41071.383929241085;7704.499207551506;7849.960750196241;7853.018372703412;7856.450048496607;7857.0964339101165;7697.461177717562;7793.8051548711455;7799.0641123065025;7800.960995195016;7802.453828232026;7813.804654883616;7841.843163136734;7846.254605812467;7851.960740196291;7853.096893857194;7768.53388796674;7791.844163116734;7794.142644309178;7829.921700782977;7831.373490120776;7676.19399963007;7754;7757.650905709256;7757.7672669819995;7758.495697779626;37933.81033094817;38254.80872595647;38264.234715305814;38274.234515309814;38334.80832595847;3079.245584831708;3118.610173728284;3188.617365916082;3197.2965947491516;3256.2510622556706;27412.177634670792;29118.85440572805;29620.111396658136;29692.109236722717;29742.70257297421;3359.160209947513;3383.5263063171174;3388.932221355584;3403.149212696826;3409.590849098124;248976;249094;249694;250503.74748126324;250809;52243;52588.47411525912;52617.210741838906;52645.47354526406;52701;54601;54705.72647136739;54807.725961369935;54823;54840.177397339074;13860.099093558887;14049.719005620034;14071.788923166161;14079.0848594841;14080.71838563223;10412.271141020208;10412.32319899204;10417.06246437809;10423;10442.425666588411;15094.24528773557;15576;15647.139407332706;15662.765058524132;15680.76478852818;5987.670678112746;6013.1581578579035;6047.606905551125;6251.12484252205;6273.560850740496;816.7508909782573;822.7778499805019;909.1999040844015;939.7133874168444;990.301837204769;27502.312442189104;27905.581416278772;27944.720552794617;28428.43143137167;28437.57343639847;800.7677773445636;968.4963818814177;969.6363863551169;972.8103019911191;986.2553771902311;14842.851571484147;15162.848371516364;15335.769963450557;15492;15627.609309767347;365456;368590;369376;369414;370003;48092;48167.5183248163;48360.27459588109;48476;48730.75634621804;1015.761296095417;1131.9377434241196;1142.765733024728;1169.2808922512593;1176.976460470803;26766.732332676424;29101.563476548294;29290.560641589967;29361.412771744872;29685.03149685014;45762.31356529588;47642.52357476381;47722.52277477181;52636.210456843946;52649.21026184687;338371;340368;341044;342017;342197;24065.879670601535;25056.749432505443;25119.87440062788;26286;26476.602850957635;40892.79553602213;41805.79097104495;42131.57868421399;42188.78905605452;42249;35180.29639407249;35552.46671299881;36152;39493.2101357977;40943.795281023406;35999.1000224986;36852.81573592115;36860.26279474449;37087.25825483421;37973;35369.46945795764;35517.094398350615;35678.286434271686;35775.46336805002;35933.46099808453;31674.68325316717;32541.67458325481;32731;33181.66818331786;33384.49923251104;25359.16673317885;25477.3630659235;25603.615945760455;25834.346171471865;25999.350016249744 10:52:47 INFO - PROCESS | 30014 | |2;jquery.html;337.2445721583653;354.0846910735748;364.8467643589692;366.1340928703616;376.84872713859164;12755.170913890603;16283.59291017725;16565.585860353498;16670.83329166708;17553.210105545248;16358.918205408985;16494.505164845043;16953.237104330303;17046;17085.82914170858;4997.629444791017;5014.222795466709;5183.948160518403;5223.71269580173;5224.190250511177;3695.926081478369;5135.12702840518;5225.399079105913;5229.032628963635;5804.680742559158;6076.118962750398;6107.694615269219;6161.137440758297;6168.691565421734;6177.320494745574;5939.316978547479;6046.667433291167;6077.939220607782;6092.69007163462;6170.043643235305;5346.465353464622;5352.384475785296;5356.437574054746;5359.517643412111;5360.973195134038;20884.686729699068;21263.8936805315;21379.786202137933;21437.67843482349;21468.785312146836;1921.788603253641;1941.6019715958196;1946.0495194754672;1970.4876732049627;1980.5147738804085;12611.936940315332;13451.681833804007;13732.862671373357;14073.718525629532;14157.504487342996;1740.7388891666226;1763.8059813420514;1780.5904641932298;1787.258287810557;1803.3147403986532;65262.3473765261;65294;66282.99999999952;66896;67226.66386668084;9337.159655631025;9735.9026409735;9742.441209406528;9786.461744604116;9827.213822894151;13190.670233244246;13203.40584673692;13217.273049982343;13218.339083045808;13248.867511324956;6955.860882782417;7090.113735783028;7145.6784444700115;7179.066721326194;7215.819604509929;6581.506387020992;6633.800985970429;6718.260991290954;6840.179178498612;6874.690638921261;5953.434423729739;6029.0052141397055;6110.663913484712;6140.447359737555;6305.274893387227;1670.983290167107;1698.1339516846497;1702.1914590569381;1706.3089448773267;1709.6495218480181;856.4304737349718;870.0646804684989;887.4808237181321;897.8563429851192;926.4256161180111;17088.743668844978;17399.47801565955;19231.51921201953;19249.13378897925;19341.51646208856;861.147464010625;872.1932212703224;879.068187721005;893.3433926064338;916.505087252876;9583.616655333848;9602.183814375716;10115;10165.644202452879;10315.948420258;382544;384107;384115;386654;405581;83875;84234;84626;85576;85829.57085214659;922.3866129024258;948.9620415183454;968.1673760565908;979.5298256836759;986.9901300987042;15552.92223538875;15725.135117568643;15977.520674379788;16105.758458436216;16325.183740813149;38929.80535097307;39278.2144357117;39345.213095738494;39589;39732;51172.488275116775;53917.460825391245;54446.72776636091;55314.72342638261;56162;7236.891446628199;7298;7363.889541656772;7450;8020.318272946632;11242.325460472397;12385.380730963236;12565.434555444845;12867.099303048697;12928.935355323163;9285.953570232106;9943.254255930979;10004.499775011365;10751.247412681038;11417.25787823822;10821.891781082404;10849.077828384676;11095.889041109485;11149.498272577592;11226.775464490827;10768.838467422838;10806.297590656583;10912.345259284468;10958;11151;7342.082239720035;7529.4729368943645;7584.772456826304;7799.766007019798;7799.869018992328;11049.447527623426;11063.225574209728;11070.623459844825;11395.487203076047;11407.942960285145 10:52:47 INFO - PROCESS | 30014 | |3;mootools.html;1219.9756004879907;1312.1995582694558;1371.958841234763;1417.3834382043813;1665.3255431550226;6267.529935254857;7073.787786366411;7330.743423980161;7378.151512576055;7654.846903061935;7539.39684825214;7591.696332146707;7591.848163036736;7592.96203518983;7595.50629209101;2057.7736448990563;2083.02098013934;2083.2396175396025;2084.895755212241;2085.165933626546;2080.6878968154824;2089.8641588296787;2102.8212601928853;2135.636941719911;2137.0810551462864;2093.256893802701;2112.271266413085;2124.702541644171;2125.426134943572;2150.849440539163;2066.5763518478752;2071.761747399038;2073.3676228750223;2074.5850829834017;2075.6678931371057;2056.5578400643785;2064.1846470644164;2083.2083808152956;2084.0830034784644;2084.3121769815925;7450.18048014718;7479.626018699043;7646.617669116577;7652.73215437457;7667.5782831944225;4326.9567304326865;4483.798229079666;4504.594586487199;4511.255642818931;4515.480719717241;2757.889684412621;2893.8119022263486;2937.720916512928;2942.573326867592;2949.247941774855;933.9906600933972;939.2251392601131;954.19370631816;954.4321128928276;958.8082383523323;10196.3372380795;10199.286049976505;10212.2851400402;10229.38623682574;10243.539040743184;3713.535808023997;3851.5763266040713;3852.4413959975645;3852.8073596320073;4062.390641403813;7291.671874765649;7383.963080184672;7387.445941554298;7393.260673932671;7396.778096657109;4232.174725928476;4235.343521754072;4242.787860606957;4244.3633454982;4246.8301267949555;3369.966300337014;3823.4264860271182;3939.2318497892634;3952.2885880541203;3985.5416627087675;3195.728363089117;3202;3340.7828491148484;3341.74936879735;3369.6967272945553;939.7086903060073;955.145145095136;969.0987381735054;977.8386566216494;980.9460479673544;797.1589972578985;836.9121242269596;850.3792231670791;856.627367095303;860.7632900952289;5016.347874776256;5238.7904483820985;5246.28417289499;5300.575953923677;5475.069238229431;849.6728759427665;862.3058437957379;867.2281669314315;875.3085062800444;888.3515034025198;3343.732501399882;3433.261848702541;3438.5186073949667;3547.6807087362263;3658.689011434005;8827.337949653802;9161.31290153228;9269;9333.346665733334;9388.530573471298;9394.71815845512;9406.1064198901;9434.292428067785;9441.055894410503;9449.291303152291;7122.323379278961;7152.892706609301;7167.89248161278;7223.313785190398;7223.422126229889;4846.733429661403;4858.92711609319;4896.2410826321975;4925.9014819704125;4976.850694479172;8579.914200858162;8622;8680.739577812676;8697.34769892248;8701.129887011248;8705.956470217609;8744.475331480131;8783.868241976503;8872.423292485968;8899.199072083544;5244.580433565229;6102.176206212104;6240.4071613196675;6241.126242325987;6244.500439964701;6941.861162776817;7161.820954475971;7191.604461754654;7371.926280737339;7373;6611.966940165461;6670.466362690876;6692.765753198614;6694.866102678016;6695.163104611924;6101.908471373022;6429.421352078335;6443.581167224115;6447.129637499065;6526.934730652632;5663.603547751618;5750.367459579359;5751.252337196138;5752.884942301047;5754.51086657622;4401.7799110043725;4406.537313582027;4421;4506.898722162816;4517.344984977226;4371.584699453547;4475.865724028285;4499.730016198908;4521.36700861873;4544.318352247189 10:52:47 INFO - PROCESS | 30014 | |4;prototype.html;285.0559186349099;289.6553101808847;290.92290543006106;297.4823806576555;303.75699440447636;4808.975955120224;4836.685615434994;4839.346688197097;4861.465238823731;4896.87757806055;4782.976085119578;4804.735739534324;4831.661783675144;4850.733209673466;4858.781354839032;3799.639034291745;3816.5229346331707;3818.7899665518385;3840.7339669594935;3866.3620502617173;3563.572371315433;3584.3469274187146;3867.6325749053794;3869.5743468218616;3873.5158105236846;3212.213007813077;3432.7793056718037;3654.104744337641;3677.227782165735;3683.5579730432387;3685.262947410502;3703.4259689748133;3744.494493243418;3758.3798673218885;3767.077066118791;3309.8676052957853;3321.2029113012945;3334.9833250833835;3339.131825725329;3362.3275344930867;4424.623906967911;4570.771461426915;4698.741569213692;4705.106029854317;4721.811127554894;4253.659707223414;4254.212970600418;4264.936025959613;4266.424032755569;4296.9140617187795;4994.675346102492;5000.82497112603;5008.398992120969;5026.748662566857;5030.748462576893;3512.1570823002553;3629.745917785756;3642.2715456908722;3650.8357123929486;3656.232191239843;5220.738963051832;5234.057869583474;5241.842744717665;5258.789648414059;5273.762680679379;3684.4841722158917;3697.186618943828;3705.203381273039;3719.2189640175325;3731.104534911656;3775.9244815103543;3777.112378591029;3777.981110094432;3781.5840257571645;3787.1442992933266;4153.7300075494995;4230.1539692061715;4236.195122926634;4313.094250207429;4316.740995540277;5026.592554084862;5039.647224694309;5055.418626857959;5067.417247016567;5073.746312684351;1301.6527893630048;1324.1525423728822;1324.2253281830044;1326.9004824638191;1331.4940322677514;795.3637090327715;857.2584714222153;859.7076993822005;863.2575984653193;875.9502763533362;4002.8598999034893;4020.8391664333685;4037.6164264394833;4040.9897525618594;4060.3706425504092;4552.681312308173;4568.2690769477385;4574.118305467534;4635.420572428447;4637.469635020435;4014.698897582693;4015.15681706839;4018.799060046986;4043.110515686544;4045.7370270932297;2460.2496238647027;2613;2734.275417014453;2746.40952195279;2756.9724302756717;4905.607551395879;4913.263010548375;4921.803127874917;4927.728974906415;4938.111139994764;5017.724025178651;5175.275461435402;5184.067651934003;5215.24378965048;5343.225232341289;4477.7313361197785;4853.514648535118;4937.432195297515;4944.269505672985;4959.578435832995;5116.718580478109;5172.568892620462;5175.637705360588;5184.870378240575;5190.740462976912;4923.335349727741;5022.799088036438;5080.288759573588;5088.135017047185;5108.386993560648;4830.6135509159885;4865.732384718733;4913.673308206836;4913.950860491349;4925.679830810986;3645.1069487975615;3676.4301533262387;3678.2091850252323;3693.538307711536;3719.832607532722;5227.790888364423;5233.058049551118;5266.447023062523;5271.815486457956;5278.498542638443;4818.229083346788;5016.799328026838;5035.608086159192;5074.923876141935;5084.211947148198;5021.271915572294;5024.211562582802;5026.798928042837;5028.522290382408;5033.169527028146;4968.130577148912;4976.32819569368;4977.377827771528;4985.202367621163;5000.699958002531;4867.610591152628;4970.975145124251;5002.824901128443;5002.849914502571;5003.849884503471;4900.496145256159;4903.656744027884;4919.458859525521;4936.333594964777;4978.950210497848 10:52:47 INFO - PROCESS | 30014 | |5;yui.html;623.4139908486023;646.3181343682417;686.2142846440826;702.1083224305136;726.6221564786312;12243.449044792984;12745.872541274584;12863.292518911456;12891.355432228398;12981.15622484539;13621.387037583308;13783.448662053532;13796.93101534491;13837.238951857644;13854.792178117312;614.6650075708727;749.5165618176273;753.8077790163528;773.6131934032984;783.34199272611;782.4131901074194;782.8943092682472;784.051297929506;785.579714852554;785.6543121026758;823.555280148722;830.0869044051525;830.4685001598981;830.8172202115525;830.8338332333527;639.7760783725705;658.1411258307907;662.787907869482;664.4617859533793;823.2878560045577;579.5798046416356;595.1340799137245;599.5653151465197;600.1088383750127;600.2616781358953;12951.67620809478;12981.350932453433;13011.86988130116;13092.86907130926;13107.47570097195;12239.571614993432;12573.622791316275;12799.168054076456;13048.739025219538;13495.325233738373;11707.121965852595;11832.112591555582;11873.881261187364;11980.34108124053;12114.939425302817;4083.4283200351974;4165.75005499671;4168.8332466701295;4172.958270417287;4174.540800511942;61865.690671546356;61878.381216187714;61969.380306196814;62390.37609623891;62775;10122.392656440637;10325.896741032493;10403.375797452178;10510.947445262726;10771.569137234423;19061.90469047646;19139.13873875679;19323.4202973911;19392.61214775725;19413.126409311615;6803.693833777492;6912.516123871281;6926.134233220848;6943.375096241362;7042.049323341385;3745.981270093687;3767.7174211933666;3792.1846802937503;3845.942310865339;3878.2825177342283;2537.7335379785227;2635.235781623346;2635.551956167456;2642;2646.325187077283;444.78872535545355;462.60216214055885;467.2174108368469;469.031450055634;471.0202778221292;497.35592407831945;507.987300317495;523.4765234765234;533.5331584863245;560.4367610551451;7950.880736788953;8050.235227653364;8358.414910956297;8482.957585212034;8501.532415717194;519.7271432497969;531.7846272259741;535.4484880573016;547.4035586198715;547.9506844384025;3832.616738326201;4128.422020917074;4178.6657067434535;4197.45433093702;4241.597048280409;100407;104405;106197.46901265444;107857.4607126975;107887;92379.5381023104;92591.53704231436;93010;94217.52891235637;96109;78983.60508197422;80138.59930700426;80548.59725701335;80645;80998.59500702577;7582.696692132253;7896.605169741605;7976.441649084509;8160.387970902325;8183.3862460316905;46445.76777116093;46848.765756171;48323;48584.271235932196;48589.27116093332;65078;69559.30440695529;69692;70438.64780676064;71913.65122534038;9924.851127233242;9950.950245248727;10087.646932357333;10179.694609161737;10242.846357304497;10432.478376081317;10563;10959.56161753521;11291.661250162508;11341.036011938748;8506.829863402822;8675.436096653697;8695;8879.733607991771;8993.55032248372;9281.118293762082;9360.812783744423;9386.624535018524;9390.107939745712;9466.195373393339;9848.310618256653;9975.850362244428;10101.14140298083;10215.642452514126;10322.071013608811;8436;8478.788030299293;8498;8837.293016558531;8949.463032218087;8296.37777166727;8751.474911505331;8804.163604457566;8862.955685221532;8965.462072275684 10:52:47 INFO - PROCESS | 30014 | __end_tp_report 10:52:47 INFO - PROCESS | 30014 | __start_cc_report 10:52:47 INFO - PROCESS | 30014 | _x_x_mozilla_cycle_collect,1012 10:52:47 INFO - PROCESS | 30014 | __end_cc_report 10:52:47 INFO - PROCESS | 30014 | __startTimestamp1470937967195__endTimestamp 10:52:47 INFO - PROCESS | 30014 | 10:52:47 INFO - PROCESS | 30014 | ------- Summary: start ------- 10:52:47 INFO - PROCESS | 30014 | Number of tests: 6 10:52:47 INFO - PROCESS | 30014 | 10:52:47 INFO - PROCESS | 30014 | [#0] dojo.html Cycles:165 Average:4769.18 Median:4925.93 stddev:507.95 (10.3%) stddev-sans-first:481.54 10:52:47 INFO - PROCESS | 30014 | Values: 2650.3 2665.6 2684.3 2696.9 2701.5 4663.3 4709.0 4775.7 4928.6 4944.5 4743.0 4816.2 4832.4 4845.2 4865.1 4377.2 4381.7 4399.1 4409.8 4586.2 4498.9 4539.7 4553.8 4576.1 4576.3 4282.6 4479.1 4480.9 4529.3 4551.5 4313.9 4400.3 4418.0 4441.0 4454.4 4389.8 4392.5 4429.6 4440.5 4446.1 4850.3 4854.6 4887.1 4890.3 4903.1 4938.0 5108.5 5138.2 5161.0 5242.6 5200.4 5239.1 5262.9 5271.8 5274.4 4638.0 4904.0 4915.9 4916.8 4919.2 5228.5 5290.7 5291.4 5297.1 5361.6 5106.5 5144.0 5151.8 5153.1 5156.4 4944.1 5188.8 5189.6 5195.5 5228.1 5053.4 5111.1 5111.8 5180.1 5180.4 5100.8 5105.9 5116.3 5116.8 5117.9 4340.5 4342.7 4345.7 4378.4 4390.4 3665.6 3666.7 3744.8 3769.0 3810.1 4432.4 4436.7 4472.3 4476.9 4479.2 5060.7 5109.4 5120.1 5128.8 5179.3 4270.8 4427.1 4434.3 4475.4 4483.0 4655.0 4656.4 4677.8 4679.5 4695.4 4917.8 4925.9 4928.2 4932.9 4976.1 4963.6 5131.1 5210.9 5219.0 5277.7 4892.8 4932.8 4933.5 4978.8 4982.8 5110.9 5126.5 5131.2 5133.2 5184.1 4931.1 5094.3 5199.1 5216.2 5217.9 4977.5 5019.5 5024.5 5069.3 5072.0 4999.9 5002.0 5002.9 5004.5 5053.2 4709.8 4825.5 4879.8 4943.5 4984.9 4949.6 4985.8 4994.2 5026.5 5046.6 4882.6 4884.0 4884.7 4891.2 4940.0 10:52:47 INFO - PROCESS | 30014 | 10:52:47 INFO - PROCESS | 30014 | [#1] ext.html Cycles:180 Average:47639.05 Median:203545.13 stddev:85175.76 (41.8%) stddev-sans-first:85341.33 10:52:47 INFO - PROCESS | 30014 | Values: 554.5 580.6 580.8 593.9 597.7 37438.3 38977.2 39051.4 39056.6 43327.0 40514.0 40934.2 40981.2 41061.6 41071.4 7704.5 7850.0 7853.0 7856.5 7857.1 7697.5 7793.8 7799.1 7801.0 7802.5 7813.8 7841.8 7846.3 7852.0 7853.1 7768.5 7791.8 7794.1 7829.9 7831.4 7676.2 7754.0 7757.7 7757.8 7758.5 37933.8 38254.8 38264.2 38274.2 38334.8 3079.2 3118.6 3188.6 3197.3 3256.3 27412.2 29118.9 29620.1 29692.1 29742.7 3359.2 3383.5 3388.9 3403.1 3409.6 248976.0 249094.0 249694.0 250503.7 250809.0 52243.0 52588.5 52617.2 52645.5 52701.0 54601.0 54705.7 54807.7 54823.0 54840.2 13860.1 14049.7 14071.8 14079.1 14080.7 10412.3 10412.3 10417.1 10423.0 10442.4 15094.2 15576.0 15647.1 15662.8 15680.8 5987.7 6013.2 6047.6 6251.1 6273.6 816.8 822.8 909.2 939.7 990.3 27502.3 27905.6 27944.7 28428.4 28437.6 800.8 968.5 969.6 972.8 986.3 14842.9 15162.8 15335.8 15492.0 15627.6 365456.0 368590.0 369376.0 369414.0 370003.0 48092.0 48167.5 48360.3 48476.0 48730.8 1015.8 1131.9 1142.8 1169.3 1177.0 26766.7 29101.6 29290.6 29361.4 29685.0 45762.3 47642.5 47722.5 52636.2 52649.2 338371.0 340368.0 341044.0 342017.0 342197.0 24065.9 25056.7 25119.9 26286.0 26476.6 40892.8 41805.8 42131.6 42188.8 42249.0 35180.3 35552.5 36152.0 39493.2 40943.8 35999.1 36852.8 36860.3 37087.3 37973.0 35369.5 35517.1 35678.3 35775.5 35933.5 31674.7 32541.7 32731.0 33181.7 33384.5 25359.2 25477.4 25603.6 25834.3 25999.4 10:52:47 INFO - PROCESS | 30014 | 10:52:47 INFO - PROCESS | 30014 | [#2] jquery.html Cycles:180 Average:24866.34 Median:222656.50 stddev:64313.49 (28.9%) stddev-sans-first:64467.54 10:52:47 INFO - PROCESS | 30014 | Values: 337.2 354.1 364.8 366.1 376.8 12755.2 16283.6 16565.6 16670.8 17553.2 16358.9 16494.5 16953.2 17046.0 17085.8 4997.6 5014.2 5183.9 5223.7 5224.2 3695.9 5135.1 5225.4 5229.0 5804.7 6076.1 6107.7 6161.1 6168.7 6177.3 5939.3 6046.7 6077.9 6092.7 6170.0 5346.5 5352.4 5356.4 5359.5 5361.0 20884.7 21263.9 21379.8 21437.7 21468.8 1921.8 1941.6 1946.0 1970.5 1980.5 12611.9 13451.7 13732.9 14073.7 14157.5 1740.7 1763.8 1780.6 1787.3 1803.3 65262.3 65294.0 66283.0 66896.0 67226.7 9337.2 9735.9 9742.4 9786.5 9827.2 13190.7 13203.4 13217.3 13218.3 13248.9 6955.9 7090.1 7145.7 7179.1 7215.8 6581.5 6633.8 6718.3 6840.2 6874.7 5953.4 6029.0 6110.7 6140.4 6305.3 1671.0 1698.1 1702.2 1706.3 1709.6 856.4 870.1 887.5 897.9 926.4 17088.7 17399.5 19231.5 19249.1 19341.5 861.1 872.2 879.1 893.3 916.5 9583.6 9602.2 10115.0 10165.6 10315.9 382544.0 384107.0 384115.0 386654.0 405581.0 83875.0 84234.0 84626.0 85576.0 85829.6 922.4 949.0 968.2 979.5 987.0 15552.9 15725.1 15977.5 16105.8 16325.2 38929.8 39278.2 39345.2 39589.0 39732.0 51172.5 53917.5 54446.7 55314.7 56162.0 7236.9 7298.0 7363.9 7450.0 8020.3 11242.3 12385.4 12565.4 12867.1 12928.9 9286.0 9943.3 10004.5 10751.2 11417.3 10821.9 10849.1 11095.9 11149.5 11226.8 10768.8 10806.3 10912.3 10958.0 11151.0 7342.1 7529.5 7584.8 7799.8 7799.9 11049.4 11063.2 11070.6 11395.5 11407.9 10:52:47 INFO - PROCESS | 30014 | 10:52:47 INFO - PROCESS | 30014 | [#3] mootools.html Cycles:180 Average:4883.07 Median:5569.34 stddev:2736.05 (49.1%) stddev-sans-first:2729.88 10:52:47 INFO - PROCESS | 30014 | Values: 1220.0 1312.2 1372.0 1417.4 1665.3 6267.5 7073.8 7330.7 7378.2 7654.8 7539.4 7591.7 7591.8 7593.0 7595.5 2057.8 2083.0 2083.2 2084.9 2085.2 2080.7 2089.9 2102.8 2135.6 2137.1 2093.3 2112.3 2124.7 2125.4 2150.8 2066.6 2071.8 2073.4 2074.6 2075.7 2056.6 2064.2 2083.2 2084.1 2084.3 7450.2 7479.6 7646.6 7652.7 7667.6 4327.0 4483.8 4504.6 4511.3 4515.5 2757.9 2893.8 2937.7 2942.6 2949.2 934.0 939.2 954.2 954.4 958.8 10196.3 10199.3 10212.3 10229.4 10243.5 3713.5 3851.6 3852.4 3852.8 4062.4 7291.7 7384.0 7387.4 7393.3 7396.8 4232.2 4235.3 4242.8 4244.4 4246.8 3370.0 3823.4 3939.2 3952.3 3985.5 3195.7 3202.0 3340.8 3341.7 3369.7 939.7 955.1 969.1 977.8 980.9 797.2 836.9 850.4 856.6 860.8 5016.3 5238.8 5246.3 5300.6 5475.1 849.7 862.3 867.2 875.3 888.4 3343.7 3433.3 3438.5 3547.7 3658.7 8827.3 9161.3 9269.0 9333.3 9388.5 9394.7 9406.1 9434.3 9441.1 9449.3 7122.3 7152.9 7167.9 7223.3 7223.4 4846.7 4858.9 4896.2 4925.9 4976.9 8579.9 8622.0 8680.7 8697.3 8701.1 8706.0 8744.5 8783.9 8872.4 8899.2 5244.6 6102.2 6240.4 6241.1 6244.5 6941.9 7161.8 7191.6 7371.9 7373.0 6612.0 6670.5 6692.8 6694.9 6695.2 6101.9 6429.4 6443.6 6447.1 6526.9 5663.6 5750.4 5751.3 5752.9 5754.5 4401.8 4406.5 4421.0 4506.9 4517.3 4371.6 4475.9 4499.7 4521.4 4544.3 10:52:47 INFO - PROCESS | 30014 | 10:52:47 INFO - PROCESS | 30014 | [#4] prototype.html Cycles:180 Average:4141.28 Median:4752.39 stddev:1203.40 (25.3%) stddev-sans-first:1171.45 10:52:47 INFO - PROCESS | 30014 | Values: 285.1 289.7 290.9 297.5 303.8 4809.0 4836.7 4839.3 4861.5 4896.9 4783.0 4804.7 4831.7 4850.7 4858.8 3799.6 3816.5 3818.8 3840.7 3866.4 3563.6 3584.3 3867.6 3869.6 3873.5 3212.2 3432.8 3654.1 3677.2 3683.6 3685.3 3703.4 3744.5 3758.4 3767.1 3309.9 3321.2 3335.0 3339.1 3362.3 4424.6 4570.8 4698.7 4705.1 4721.8 4253.7 4254.2 4264.9 4266.4 4296.9 4994.7 5000.8 5008.4 5026.7 5030.7 3512.2 3629.7 3642.3 3650.8 3656.2 5220.7 5234.1 5241.8 5258.8 5273.8 3684.5 3697.2 3705.2 3719.2 3731.1 3775.9 3777.1 3778.0 3781.6 3787.1 4153.7 4230.2 4236.2 4313.1 4316.7 5026.6 5039.6 5055.4 5067.4 5073.7 1301.7 1324.2 1324.2 1326.9 1331.5 795.4 857.3 859.7 863.3 876.0 4002.9 4020.8 4037.6 4041.0 4060.4 4552.7 4568.3 4574.1 4635.4 4637.5 4014.7 4015.2 4018.8 4043.1 4045.7 2460.2 2613.0 2734.3 2746.4 2757.0 4905.6 4913.3 4921.8 4927.7 4938.1 5017.7 5175.3 5184.1 5215.2 5343.2 4477.7 4853.5 4937.4 4944.3 4959.6 5116.7 5172.6 5175.6 5184.9 5190.7 4923.3 5022.8 5080.3 5088.1 5108.4 4830.6 4865.7 4913.7 4914.0 4925.7 3645.1 3676.4 3678.2 3693.5 3719.8 5227.8 5233.1 5266.4 5271.8 5278.5 4818.2 5016.8 5035.6 5074.9 5084.2 5021.3 5024.2 5026.8 5028.5 5033.2 4968.1 4976.3 4977.4 4985.2 5000.7 4867.6 4971.0 5002.8 5002.8 5003.8 4900.5 4903.7 4919.5 4936.3 4979.0 10:52:47 INFO - PROCESS | 30014 | 10:52:47 INFO - PROCESS | 30014 | [#5] yui.html Cycles:180 Average:18411.02 Median:570.01 stddev:27598.18 (4841.7%) stddev-sans-first:27643.28 10:52:47 INFO - PROCESS | 30014 | Values: 623.4 646.3 686.2 702.1 726.6 12243.4 12745.9 12863.3 12891.4 12981.2 13621.4 13783.4 13796.9 13837.2 13854.8 614.7 749.5 753.8 773.6 783.3 782.4 782.9 784.1 785.6 785.7 823.6 830.1 830.5 830.8 830.8 639.8 658.1 662.8 664.5 823.3 579.6 595.1 599.6 600.1 600.3 12951.7 12981.4 13011.9 13092.9 13107.5 12239.6 12573.6 12799.2 13048.7 13495.3 11707.1 11832.1 11873.9 11980.3 12114.9 4083.4 4165.8 4168.8 4173.0 4174.5 61865.7 61878.4 61969.4 62390.4 62775.0 10122.4 10325.9 10403.4 10510.9 10771.6 19061.9 19139.1 19323.4 19392.6 19413.1 6803.7 6912.5 6926.1 6943.4 7042.0 3746.0 3767.7 3792.2 3845.9 3878.3 2537.7 2635.2 2635.6 2642.0 2646.3 444.8 462.6 467.2 469.0 471.0 497.4 508.0 523.5 533.5 560.4 7950.9 8050.2 8358.4 8483.0 8501.5 519.7 531.8 535.4 547.4 548.0 3832.6 4128.4 4178.7 4197.5 4241.6 100407.0 104405.0 106197.5 107857.5 107887.0 92379.5 92591.5 93010.0 94217.5 96109.0 78983.6 80138.6 80548.6 80645.0 80998.6 7582.7 7896.6 7976.4 8160.4 8183.4 46445.8 46848.8 48323.0 48584.3 48589.3 65078.0 69559.3 69692.0 70438.6 71913.7 9924.9 9951.0 10087.6 10179.7 10242.8 10432.5 10563.0 10959.6 11291.7 11341.0 8506.8 8675.4 8695.0 8879.7 8993.6 9281.1 9360.8 9386.6 9390.1 9466.2 9848.3 9975.9 10101.1 10215.6 10322.1 8436.0 8478.8 8498.0 8837.3 8949.5 8296.4 8751.5 8804.2 8863.0 8965.5 10:52:47 INFO - PROCESS | 30014 | -------- Summary: end -------- 10:52:47 INFO - PROCESS | 30014 | 10:52:48 INFO - TEST-INFO | 30014: exit 0 10:52:48 INFO - TEST-OK | dromaeo_css | took 1119748ms 10:52:48 INFO - TEST-START | kraken 10:52:48 INFO - operating with platform_type : linux_ 10:52:48 INFO - Initialising browser for kraken test... 10:52:48 INFO - TEST-INFO | started process 30197 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNlTeX_/profile http://localhost:53002/getInfo.html) 10:52:52 INFO - PROCESS | 30197 | __metrics Screen width/height:1600/1200 10:52:52 INFO - PROCESS | 30197 | colorDepth:24 10:52:52 INFO - PROCESS | 30197 | Browser inner width/height: 1024/697 10:52:52 INFO - PROCESS | 30197 | __metrics 10:52:53 INFO - PROCESS | 30197 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:52:53 INFO - PROCESS | 30197 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:52:53 INFO - PROCESS | 30197 | console.error: PushService: 10:52:53 INFO - PROCESS | 30197 | stateChangeProcessEnqueue: Error transitioning state 10:52:53 INFO - PROCESS | 30197 | UnknownError 10:52:54 INFO - TEST-INFO | 30197: exit 0 10:52:54 INFO - Browser initialized. 10:52:54 INFO - Running cycle 1/1 for kraken test... 10:52:54 INFO - TEST-INFO | started process 30277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNlTeX_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:53:06 INFO - PROCESS | 30277 | RSS: Main: 157151232 10:53:06 INFO - PROCESS | 30277 | 10:53:08 INFO - PROCESS | 30277 | Cycle 1(1): loaded http://localhost:53002/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53002/tests/kraken/driver.html?testName=audio-beat-detection) 10:53:09 INFO - PROCESS | 30277 | RSS: Main: 212549632 10:53:09 INFO - PROCESS | 30277 | 10:53:12 INFO - PROCESS | 30277 | Cycle 1(1): loaded http://localhost:53002/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53002/tests/kraken/driver.html?testName=audio-dft) 10:53:13 INFO - PROCESS | 30277 | RSS: Main: 190976000 10:53:13 INFO - PROCESS | 30277 | 10:53:16 INFO - PROCESS | 30277 | Cycle 1(1): loaded http://localhost:53002/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53002/tests/kraken/driver.html?testName=audio-fft) 10:53:17 INFO - PROCESS | 30277 | RSS: Main: 270499840 10:53:17 INFO - PROCESS | 30277 | 10:53:19 INFO - PROCESS | 30277 | Cycle 1(1): loaded http://localhost:53002/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53002/tests/kraken/driver.html?testName=audio-oscillator) 10:53:19 INFO - PROCESS | 30277 | RSS: Main: 179253248 10:53:19 INFO - PROCESS | 30277 | 10:53:22 INFO - PROCESS | 30277 | Cycle 1(1): loaded http://localhost:53002/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53002/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:53:22 INFO - PROCESS | 30277 | RSS: Main: 184365056 10:53:22 INFO - PROCESS | 30277 | 10:53:26 INFO - PROCESS | 30277 | Cycle 1(1): loaded http://localhost:53002/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53002/tests/kraken/driver.html?testName=imaging-darkroom) 10:53:26 INFO - PROCESS | 30277 | RSS: Main: 221048832 10:53:26 INFO - PROCESS | 30277 | 10:53:30 INFO - PROCESS | 30277 | Cycle 1(1): loaded http://localhost:53002/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53002/tests/kraken/driver.html?testName=imaging-desaturate) 10:53:30 INFO - PROCESS | 30277 | RSS: Main: 214630400 10:53:30 INFO - PROCESS | 30277 | 10:53:33 INFO - PROCESS | 30277 | Cycle 1(1): loaded http://localhost:53002/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53002/tests/kraken/driver.html?testName=json-parse-financial) 10:53:34 INFO - PROCESS | 30277 | RSS: Main: 217608192 10:53:34 INFO - PROCESS | 30277 | 10:53:35 INFO - PROCESS | 30277 | Cycle 1(1): loaded http://localhost:53002/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53002/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:53:36 INFO - PROCESS | 30277 | RSS: Main: 183169024 10:53:36 INFO - PROCESS | 30277 | 10:53:38 INFO - PROCESS | 30277 | Cycle 1(1): loaded http://localhost:53002/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53002/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:53:39 INFO - PROCESS | 30277 | RSS: Main: 190136320 10:53:39 INFO - PROCESS | 30277 | 10:53:41 INFO - PROCESS | 30277 | Cycle 1(1): loaded http://localhost:53002/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53002/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:53:42 INFO - PROCESS | 30277 | RSS: Main: 191954944 10:53:42 INFO - PROCESS | 30277 | 10:53:44 INFO - PROCESS | 30277 | Cycle 1(1): loaded http://localhost:53002/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53002/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:53:45 INFO - PROCESS | 30277 | RSS: Main: 187863040 10:53:45 INFO - PROCESS | 30277 | 10:53:48 INFO - PROCESS | 30277 | Cycle 1(1): loaded http://localhost:53002/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53002/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:53:48 INFO - PROCESS | 30277 | RSS: Main: 191410176 10:53:48 INFO - PROCESS | 30277 | 10:53:50 INFO - PROCESS | 30277 | Cycle 1(1): loaded http://localhost:53002/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53002/tests/kraken/driver.html?testName=ai-astar) 10:53:50 INFO - PROCESS | 30277 | RSS: Main: 242569216 10:53:50 INFO - PROCESS | 30277 | 10:53:50 INFO - PROCESS | 30277 | __start_tp_report 10:53:50 INFO - PROCESS | 30277 | _x_x_mozilla_page_load 10:53:50 INFO - PROCESS | 30277 | _x_x_mozilla_page_load_details 10:53:50 INFO - PROCESS | 30277 | |i|pagename|runs| 10:53:50 INFO - PROCESS | 30277 | |0;ai-astar;105;114;113;115;113;114;113;112;113;112 10:53:50 INFO - PROCESS | 30277 | |1;audio-beat-detection;160;122;124;185;123;122;141;121;198;127 10:53:50 INFO - PROCESS | 30277 | |2;audio-dft;162;159;160;163;162;162;160;161;163;161 10:53:50 INFO - PROCESS | 30277 | |3;audio-fft;74;76;74;100;77;77;86;75;99;76 10:53:50 INFO - PROCESS | 30277 | |4;audio-oscillator;86;86;127;85;86;86;117;86;86;130 10:53:50 INFO - PROCESS | 30277 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;116;117;118 10:53:50 INFO - PROCESS | 30277 | |6;imaging-darkroom;146;146;146;146;147;145;146;146;147;146 10:53:50 INFO - PROCESS | 30277 | |7;imaging-desaturate;96;96;95;95;95;95;95;95;95;95 10:53:50 INFO - PROCESS | 30277 | |8;json-parse-financial;63;63;63;62;68;65;63;63;62;63 10:53:50 INFO - PROCESS | 30277 | |9;json-stringify-tinderbox;66;66;66;66;66;69;66;65;66;66 10:53:50 INFO - PROCESS | 30277 | |10;stanford-crypto-aes;86;80;89;85;80;88;82;79;89;85 10:53:50 INFO - PROCESS | 30277 | |11;stanford-crypto-ccm;128;130;140;134;139;129;129;129;158;137 10:53:50 INFO - PROCESS | 30277 | |12;stanford-crypto-pbkdf2;168;168;180;168;165;165;167;166;166;173 10:53:50 INFO - PROCESS | 30277 | |13;stanford-crypto-sha256-iterative;72;67;67;67;67;72;67;66;67;67 10:53:50 INFO - PROCESS | 30277 | __end_tp_report 10:53:50 INFO - PROCESS | 30277 | __start_cc_report 10:53:50 INFO - PROCESS | 30277 | _x_x_mozilla_cycle_collect,1980 10:53:50 INFO - PROCESS | 30277 | __end_cc_report 10:53:50 INFO - PROCESS | 30277 | __startTimestamp1470938030838__endTimestamp 10:53:50 INFO - PROCESS | 30277 | 10:53:50 INFO - PROCESS | 30277 | ------- Summary: start ------- 10:53:50 INFO - PROCESS | 30277 | Number of tests: 14 10:53:50 INFO - PROCESS | 30277 | 10:53:50 INFO - PROCESS | 30277 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:2.76 (2.4%) stddev-sans-first:0.97 10:53:50 INFO - PROCESS | 30277 | Values: 105.0 114.0 113.0 115.0 113.0 114.0 113.0 112.0 113.0 112.0 10:53:50 INFO - PROCESS | 30277 | 10:53:50 INFO - PROCESS | 30277 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:134.00 stddev:28.79 (21.5%) stddev-sans-first:29.82 10:53:50 INFO - PROCESS | 30277 | Values: 160.0 122.0 124.0 185.0 123.0 122.0 141.0 121.0 198.0 127.0 10:53:50 INFO - PROCESS | 30277 | 10:53:50 INFO - PROCESS | 30277 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.34 (0.8%) stddev-sans-first:1.39 10:53:50 INFO - PROCESS | 30277 | Values: 162.0 159.0 160.0 163.0 162.0 162.0 160.0 161.0 163.0 161.0 10:53:50 INFO - PROCESS | 30277 | 10:53:50 INFO - PROCESS | 30277 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.50 stddev:10.13 (13.2%) stddev-sans-first:10.39 10:53:50 INFO - PROCESS | 30277 | Values: 74.0 76.0 74.0 100.0 77.0 77.0 86.0 75.0 99.0 76.0 10:53:50 INFO - PROCESS | 30277 | 10:53:50 INFO - PROCESS | 30277 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:86.00 stddev:19.02 (22.1%) stddev-sans-first:19.72 10:53:50 INFO - PROCESS | 30277 | Values: 86.0 86.0 127.0 85.0 86.0 86.0 117.0 86.0 86.0 130.0 10:53:50 INFO - PROCESS | 30277 | 10:53:50 INFO - PROCESS | 30277 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 10:53:50 INFO - PROCESS | 30277 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 118.0 10:53:50 INFO - PROCESS | 30277 | 10:53:50 INFO - PROCESS | 30277 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 10:53:50 INFO - PROCESS | 30277 | Values: 146.0 146.0 146.0 146.0 147.0 145.0 146.0 146.0 147.0 146.0 10:53:50 INFO - PROCESS | 30277 | 10:53:50 INFO - PROCESS | 30277 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 10:53:50 INFO - PROCESS | 30277 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 10:53:50 INFO - PROCESS | 30277 | 10:53:50 INFO - PROCESS | 30277 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:63.00 stddev:1.78 (2.8%) stddev-sans-first:1.88 10:53:50 INFO - PROCESS | 30277 | Values: 63.0 63.0 63.0 62.0 68.0 65.0 63.0 63.0 62.0 63.0 10:53:50 INFO - PROCESS | 30277 | 10:53:50 INFO - PROCESS | 30277 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 10:53:50 INFO - PROCESS | 30277 | Values: 66.0 66.0 66.0 66.0 66.0 69.0 66.0 65.0 66.0 66.0 10:53:50 INFO - PROCESS | 30277 | 10:53:50 INFO - PROCESS | 30277 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:85.50 stddev:3.83 (4.5%) stddev-sans-first:4.01 10:53:50 INFO - PROCESS | 30277 | Values: 86.0 80.0 89.0 85.0 80.0 88.0 82.0 79.0 89.0 85.0 10:53:50 INFO - PROCESS | 30277 | 10:53:50 INFO - PROCESS | 30277 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:135.50 stddev:9.17 (6.8%) stddev-sans-first:9.33 10:53:50 INFO - PROCESS | 30277 | Values: 128.0 130.0 140.0 134.0 139.0 129.0 129.0 129.0 158.0 137.0 10:53:50 INFO - PROCESS | 30277 | 10:53:50 INFO - PROCESS | 30277 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:168.00 stddev:4.62 (2.8%) stddev-sans-first:4.90 10:53:50 INFO - PROCESS | 30277 | Values: 168.0 168.0 180.0 168.0 165.0 165.0 167.0 166.0 166.0 173.0 10:53:50 INFO - PROCESS | 30277 | 10:53:50 INFO - PROCESS | 30277 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.00 stddev:2.18 (3.3%) stddev-sans-first:1.74 10:53:50 INFO - PROCESS | 30277 | Values: 72.0 67.0 67.0 67.0 67.0 72.0 67.0 66.0 67.0 67.0 10:53:50 INFO - PROCESS | 30277 | -------- Summary: end -------- 10:53:50 INFO - PROCESS | 30277 | 10:53:51 INFO - TEST-INFO | 30277: exit 0 10:53:51 INFO - TEST-OK | kraken | took 63879ms 10:53:51 INFO - SUITE-END | took 1183s 10:53:51 INFO - Completed test suite (00:19:43) 10:53:51 INFO - javascript benchmark 10:53:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2650.297671117154, 2665.5735082386823, 2684.3020814588203, 2696.87864046118, 2701.459708058389, 4663.347131401598, 4709.0, 4775.665703400759, 4928.5564299213065, 4944.530269624389, 4743.0, 4816.157172494817, 4832.420109586846, 4845.152098382778, 4865.124277630025, 4377.212101821671, 4381.715188512752, 4399.098184872094, 4409.82360705573, 4586.1974154522995, 4498.8875278117985, 4539.727616343013, 4553.795079221443, 4576.06190730901, 4576.267797152456, 4282.635975942048, 4479.059397526524, 4480.865574032784, 4529.275315949432, 4551.476580193271, 4313.913721725579, 4400.317950717644, 4417.955820441786, 4441.045175287329, 4454.35411865281, 4389.780510974439, 4392.516823149451, 4429.6013358797545, 4440.489343725449, 4446.066326071529, 4850.296706977504, 4854.563089321978, 4887.0714564232685, 4890.339804126468, 4903.117438861003, 4937.950620493785, 5108.540231379194, 5138.203578445347, 5161.0, 5242.580593552507, 5200.401953775288, 5239.1093514102695, 5262.894742105136, 5271.789128434858, 5274.393444753826, 4638.0, 4903.950960490385, 4915.852524424273, 4916.778744956486, 4919.237518184687, 5228.529432351107, 5290.709011004432, 5291.444398338119, 5297.125974214211, 5361.571074314045, 5106.540411362995, 5144.0, 5151.845444636667, 5153.149730294459, 5156.407013193456, 4944.085344211332, 5188.818391356284, 5189.584833213409, 5195.454477279907, 5228.05894938907, 5053.36832895888, 5111.105556527667, 5111.846644600668, 5180.093483640348, 5180.404253510895, 5100.770465329069, 5105.9489405106215, 5116.334876466036, 5116.795328186905, 5117.948820511747, 4340.52254252032, 4342.717723347972, 4345.674074444366, 4378.365137055109, 4390.385346051556, 3665.633436656313, 3666.6883314917995, 3744.756590821588, 3768.9811550942068, 3810.0665336992615, 4432.3794668746405, 4436.733795972252, 4472.329150627367, 4476.888077798081, 4479.216137175981, 5060.696358218519, 5109.3613298337705, 5120.078385890575, 5128.8461346159675, 5179.300794392784, 4270.7864606769535, 4427.136708341843, 4434.3348497724955, 4475.4181956345465, 4482.977585112054, 4654.953450465519, 4656.4412270527755, 4677.812887484531, 4679.508651591602, 4695.389599352063, 4917.827876024322, 4925.926111108336, 4928.162212423968, 4932.901341973212, 4976.0794253063295, 4963.553280204799, 5131.127708289525, 5210.947890521046, 5219.034478621467, 5277.656952298088, 4892.755362231803, 4932.802687892444, 4933.506649335038, 4978.775955081957, 4982.775775090057, 5110.948890511196, 5126.487351264844, 5131.153359695758, 5133.204353325241, 5184.0927837629015, 4931.112399767932, 5094.286799848099, 5199.142141546602, 5216.165413533817, 5217.895642087061, 4977.477364876636, 5019.472955339636, 5024.522670346311, 5069.290299358019, 5071.974640126776, 4999.8750031248055, 5002.0, 5002.949970500248, 5004.499550045112, 5053.216751403538, 4709.8116075357975, 4825.4933232011535, 4879.829205977774, 4943.505649435027, 4984.900301993867, 4949.6287778416045, 4985.775640096277, 4994.225894986283, 5026.547610715053, 5046.571041461517, 4882.584980276574, 4884.047610716018, 4884.731339776205, 4891.168501354707, 4940.0], "value": 4736.256215392305, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.5203399059814, 580.5645765675746, 580.7909152705029, 593.9465448109669, 597.6682940967761, 37438.25123497529, 38977.22045559087, 39051.41422878659, 39056.60943390565, 43327.0, 40514.0, 40934.18131637365, 40981.180376392454, 41061.58938410615, 41071.383929241085, 7704.499207551506, 7849.960750196241, 7853.018372703412, 7856.450048496607, 7857.0964339101165, 7697.461177717562, 7793.8051548711455, 7799.0641123065025, 7800.960995195016, 7802.453828232026, 7813.804654883616, 7841.843163136734, 7846.254605812467, 7851.960740196291, 7853.096893857194, 7768.53388796674, 7791.844163116734, 7794.142644309178, 7829.921700782977, 7831.373490120776, 7676.19399963007, 7754.0, 7757.650905709256, 7757.7672669819995, 7758.495697779626, 37933.81033094817, 38254.80872595647, 38264.234715305814, 38274.234515309814, 38334.80832595847, 3079.245584831708, 3118.610173728284, 3188.617365916082, 3197.2965947491516, 3256.2510622556706, 27412.177634670792, 29118.85440572805, 29620.111396658136, 29692.109236722717, 29742.70257297421, 3359.160209947513, 3383.5263063171174, 3388.932221355584, 3403.149212696826, 3409.590849098124, 248976.0, 249094.0, 249694.0, 250503.74748126324, 250809.0, 52243.0, 52588.47411525912, 52617.210741838906, 52645.47354526406, 52701.0, 54601.0, 54705.72647136739, 54807.725961369935, 54823.0, 54840.177397339074, 13860.099093558887, 14049.719005620034, 14071.788923166161, 14079.0848594841, 14080.71838563223, 10412.271141020208, 10412.32319899204, 10417.06246437809, 10423.0, 10442.425666588411, 15094.24528773557, 15576.0, 15647.139407332706, 15662.765058524132, 15680.76478852818, 5987.670678112746, 6013.1581578579035, 6047.606905551125, 6251.12484252205, 6273.560850740496, 816.7508909782573, 822.7778499805019, 909.1999040844015, 939.7133874168444, 990.301837204769, 27502.312442189104, 27905.581416278772, 27944.720552794617, 28428.43143137167, 28437.57343639847, 800.7677773445636, 968.4963818814177, 969.6363863551169, 972.8103019911191, 986.2553771902311, 14842.851571484147, 15162.848371516364, 15335.769963450557, 15492.0, 15627.609309767347, 365456.0, 368590.0, 369376.0, 369414.0, 370003.0, 48092.0, 48167.5183248163, 48360.27459588109, 48476.0, 48730.75634621804, 1015.761296095417, 1131.9377434241196, 1142.765733024728, 1169.2808922512593, 1176.976460470803, 26766.732332676424, 29101.563476548294, 29290.560641589967, 29361.412771744872, 29685.03149685014, 45762.31356529588, 47642.52357476381, 47722.52277477181, 52636.210456843946, 52649.21026184687, 338371.0, 340368.0, 341044.0, 342017.0, 342197.0, 24065.879670601535, 25056.749432505443, 25119.87440062788, 26286.0, 26476.602850957635, 40892.79553602213, 41805.79097104495, 42131.57868421399, 42188.78905605452, 42249.0, 35180.29639407249, 35552.46671299881, 36152.0, 39493.2101357977, 40943.795281023406, 35999.1000224986, 36852.81573592115, 36860.26279474449, 37087.25825483421, 37973.0, 35369.46945795764, 35517.094398350615, 35678.286434271686, 35775.46336805002, 35933.46099808453, 31674.68325316717, 32541.67458325481, 32731.0, 33181.66818331786, 33384.49923251104, 25359.16673317885, 25477.3630659235, 25603.615945760455, 25834.346171471865, 25999.350016249744], "value": 17446.62527902145, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.2445721583653, 354.0846910735748, 364.8467643589692, 366.1340928703616, 376.84872713859164, 12755.170913890603, 16283.59291017725, 16565.585860353498, 16670.83329166708, 17553.210105545248, 16358.918205408985, 16494.505164845043, 16953.237104330303, 17046.0, 17085.82914170858, 4997.629444791017, 5014.222795466709, 5183.948160518403, 5223.71269580173, 5224.190250511177, 3695.926081478369, 5135.12702840518, 5225.399079105913, 5229.032628963635, 5804.680742559158, 6076.118962750398, 6107.694615269219, 6161.137440758297, 6168.691565421734, 6177.320494745574, 5939.316978547479, 6046.667433291167, 6077.939220607782, 6092.69007163462, 6170.043643235305, 5346.465353464622, 5352.384475785296, 5356.437574054746, 5359.517643412111, 5360.973195134038, 20884.686729699068, 21263.8936805315, 21379.786202137933, 21437.67843482349, 21468.785312146836, 1921.788603253641, 1941.6019715958196, 1946.0495194754672, 1970.4876732049627, 1980.5147738804085, 12611.936940315332, 13451.681833804007, 13732.862671373357, 14073.718525629532, 14157.504487342996, 1740.7388891666226, 1763.8059813420514, 1780.5904641932298, 1787.258287810557, 1803.3147403986532, 65262.3473765261, 65294.0, 66282.99999999952, 66896.0, 67226.66386668084, 9337.159655631025, 9735.9026409735, 9742.441209406528, 9786.461744604116, 9827.213822894151, 13190.670233244246, 13203.40584673692, 13217.273049982343, 13218.339083045808, 13248.867511324956, 6955.860882782417, 7090.113735783028, 7145.6784444700115, 7179.066721326194, 7215.819604509929, 6581.506387020992, 6633.800985970429, 6718.260991290954, 6840.179178498612, 6874.690638921261, 5953.434423729739, 6029.0052141397055, 6110.663913484712, 6140.447359737555, 6305.274893387227, 1670.983290167107, 1698.1339516846497, 1702.1914590569381, 1706.3089448773267, 1709.6495218480181, 856.4304737349718, 870.0646804684989, 887.4808237181321, 897.8563429851192, 926.4256161180111, 17088.743668844978, 17399.47801565955, 19231.51921201953, 19249.13378897925, 19341.51646208856, 861.147464010625, 872.1932212703224, 879.068187721005, 893.3433926064338, 916.505087252876, 9583.616655333848, 9602.183814375716, 10115.0, 10165.644202452879, 10315.948420258, 382544.0, 384107.0, 384115.0, 386654.0, 405581.0, 83875.0, 84234.0, 84626.0, 85576.0, 85829.57085214659, 922.3866129024258, 948.9620415183454, 968.1673760565908, 979.5298256836759, 986.9901300987042, 15552.92223538875, 15725.135117568643, 15977.520674379788, 16105.758458436216, 16325.183740813149, 38929.80535097307, 39278.2144357117, 39345.213095738494, 39589.0, 39732.0, 51172.488275116775, 53917.460825391245, 54446.72776636091, 55314.72342638261, 56162.0, 7236.891446628199, 7298.0, 7363.889541656772, 7450.0, 8020.318272946632, 11242.325460472397, 12385.380730963236, 12565.434555444845, 12867.099303048697, 12928.935355323163, 9285.953570232106, 9943.254255930979, 10004.499775011365, 10751.247412681038, 11417.25787823822, 10821.891781082404, 10849.077828384676, 11095.889041109485, 11149.498272577592, 11226.775464490827, 10768.838467422838, 10806.297590656583, 10912.345259284468, 10958.0, 11151.0, 7342.082239720035, 7529.4729368943645, 7584.772456826304, 7799.766007019798, 7799.869018992328, 11049.447527623426, 11063.225574209728, 11070.623459844825, 11395.487203076047, 11407.942960285145], "value": 8524.900804766818, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1219.9756004879907, 1312.1995582694558, 1371.958841234763, 1417.3834382043813, 1665.3255431550226, 6267.529935254857, 7073.787786366411, 7330.743423980161, 7378.151512576055, 7654.846903061935, 7539.39684825214, 7591.696332146707, 7591.848163036736, 7592.96203518983, 7595.50629209101, 2057.7736448990563, 2083.02098013934, 2083.2396175396025, 2084.895755212241, 2085.165933626546, 2080.6878968154824, 2089.8641588296787, 2102.8212601928853, 2135.636941719911, 2137.0810551462864, 2093.256893802701, 2112.271266413085, 2124.702541644171, 2125.426134943572, 2150.849440539163, 2066.5763518478752, 2071.761747399038, 2073.3676228750223, 2074.5850829834017, 2075.6678931371057, 2056.5578400643785, 2064.1846470644164, 2083.2083808152956, 2084.0830034784644, 2084.3121769815925, 7450.18048014718, 7479.626018699043, 7646.617669116577, 7652.73215437457, 7667.5782831944225, 4326.9567304326865, 4483.798229079666, 4504.594586487199, 4511.255642818931, 4515.480719717241, 2757.889684412621, 2893.8119022263486, 2937.720916512928, 2942.573326867592, 2949.247941774855, 933.9906600933972, 939.2251392601131, 954.19370631816, 954.4321128928276, 958.8082383523323, 10196.3372380795, 10199.286049976505, 10212.2851400402, 10229.38623682574, 10243.539040743184, 3713.535808023997, 3851.5763266040713, 3852.4413959975645, 3852.8073596320073, 4062.390641403813, 7291.671874765649, 7383.963080184672, 7387.445941554298, 7393.260673932671, 7396.778096657109, 4232.174725928476, 4235.343521754072, 4242.787860606957, 4244.3633454982, 4246.8301267949555, 3369.966300337014, 3823.4264860271182, 3939.2318497892634, 3952.2885880541203, 3985.5416627087675, 3195.728363089117, 3202.0, 3340.7828491148484, 3341.74936879735, 3369.6967272945553, 939.7086903060073, 955.145145095136, 969.0987381735054, 977.8386566216494, 980.9460479673544, 797.1589972578985, 836.9121242269596, 850.3792231670791, 856.627367095303, 860.7632900952289, 5016.347874776256, 5238.7904483820985, 5246.28417289499, 5300.575953923677, 5475.069238229431, 849.6728759427665, 862.3058437957379, 867.2281669314315, 875.3085062800444, 888.3515034025198, 3343.732501399882, 3433.261848702541, 3438.5186073949667, 3547.6807087362263, 3658.689011434005, 8827.337949653802, 9161.31290153228, 9269.0, 9333.346665733334, 9388.530573471298, 9394.71815845512, 9406.1064198901, 9434.292428067785, 9441.055894410503, 9449.291303152291, 7122.323379278961, 7152.892706609301, 7167.89248161278, 7223.313785190398, 7223.422126229889, 4846.733429661403, 4858.92711609319, 4896.2410826321975, 4925.9014819704125, 4976.850694479172, 8579.914200858162, 8622.0, 8680.739577812676, 8697.34769892248, 8701.129887011248, 8705.956470217609, 8744.475331480131, 8783.868241976503, 8872.423292485968, 8899.199072083544, 5244.580433565229, 6102.176206212104, 6240.4071613196675, 6241.126242325987, 6244.500439964701, 6941.861162776817, 7161.820954475971, 7191.604461754654, 7371.926280737339, 7373.0, 6611.966940165461, 6670.466362690876, 6692.765753198614, 6694.866102678016, 6695.163104611924, 6101.908471373022, 6429.421352078335, 6443.581167224115, 6447.129637499065, 6526.934730652632, 5663.603547751618, 5750.367459579359, 5751.252337196138, 5752.884942301047, 5754.51086657622, 4401.7799110043725, 4406.537313582027, 4421.0, 4506.898722162816, 4517.344984977226, 4371.584699453547, 4475.865724028285, 4499.730016198908, 4521.36700861873, 4544.318352247189], "value": 3941.1436143736264, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.0559186349099, 289.6553101808847, 290.92290543006106, 297.4823806576555, 303.75699440447636, 4808.975955120224, 4836.685615434994, 4839.346688197097, 4861.465238823731, 4896.87757806055, 4782.976085119578, 4804.735739534324, 4831.661783675144, 4850.733209673466, 4858.781354839032, 3799.639034291745, 3816.5229346331707, 3818.7899665518385, 3840.7339669594935, 3866.3620502617173, 3563.572371315433, 3584.3469274187146, 3867.6325749053794, 3869.5743468218616, 3873.5158105236846, 3212.213007813077, 3432.7793056718037, 3654.104744337641, 3677.227782165735, 3683.5579730432387, 3685.262947410502, 3703.4259689748133, 3744.494493243418, 3758.3798673218885, 3767.077066118791, 3309.8676052957853, 3321.2029113012945, 3334.9833250833835, 3339.131825725329, 3362.3275344930867, 4424.623906967911, 4570.771461426915, 4698.741569213692, 4705.106029854317, 4721.811127554894, 4253.659707223414, 4254.212970600418, 4264.936025959613, 4266.424032755569, 4296.9140617187795, 4994.675346102492, 5000.82497112603, 5008.398992120969, 5026.748662566857, 5030.748462576893, 3512.1570823002553, 3629.745917785756, 3642.2715456908722, 3650.8357123929486, 3656.232191239843, 5220.738963051832, 5234.057869583474, 5241.842744717665, 5258.789648414059, 5273.762680679379, 3684.4841722158917, 3697.186618943828, 3705.203381273039, 3719.2189640175325, 3731.104534911656, 3775.9244815103543, 3777.112378591029, 3777.981110094432, 3781.5840257571645, 3787.1442992933266, 4153.7300075494995, 4230.1539692061715, 4236.195122926634, 4313.094250207429, 4316.740995540277, 5026.592554084862, 5039.647224694309, 5055.418626857959, 5067.417247016567, 5073.746312684351, 1301.6527893630048, 1324.1525423728822, 1324.2253281830044, 1326.9004824638191, 1331.4940322677514, 795.3637090327715, 857.2584714222153, 859.7076993822005, 863.2575984653193, 875.9502763533362, 4002.8598999034893, 4020.8391664333685, 4037.6164264394833, 4040.9897525618594, 4060.3706425504092, 4552.681312308173, 4568.2690769477385, 4574.118305467534, 4635.420572428447, 4637.469635020435, 4014.698897582693, 4015.15681706839, 4018.799060046986, 4043.110515686544, 4045.7370270932297, 2460.2496238647027, 2613.0, 2734.275417014453, 2746.40952195279, 2756.9724302756717, 4905.607551395879, 4913.263010548375, 4921.803127874917, 4927.728974906415, 4938.111139994764, 5017.724025178651, 5175.275461435402, 5184.067651934003, 5215.24378965048, 5343.225232341289, 4477.7313361197785, 4853.514648535118, 4937.432195297515, 4944.269505672985, 4959.578435832995, 5116.718580478109, 5172.568892620462, 5175.637705360588, 5184.870378240575, 5190.740462976912, 4923.335349727741, 5022.799088036438, 5080.288759573588, 5088.135017047185, 5108.386993560648, 4830.6135509159885, 4865.732384718733, 4913.673308206836, 4913.950860491349, 4925.679830810986, 3645.1069487975615, 3676.4301533262387, 3678.2091850252323, 3693.538307711536, 3719.832607532722, 5227.790888364423, 5233.058049551118, 5266.447023062523, 5271.815486457956, 5278.498542638443, 4818.229083346788, 5016.799328026838, 5035.608086159192, 5074.923876141935, 5084.211947148198, 5021.271915572294, 5024.211562582802, 5026.798928042837, 5028.522290382408, 5033.169527028146, 4968.130577148912, 4976.32819569368, 4977.377827771528, 4985.202367621163, 5000.699958002531, 4867.610591152628, 4970.975145124251, 5002.824901128443, 5002.849914502571, 5003.849884503471, 4900.496145256159, 4903.656744027884, 4919.458859525521, 4936.333594964777, 4978.950210497848], "value": 3760.6755238477585, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.4139908486023, 646.3181343682417, 686.2142846440826, 702.1083224305136, 726.6221564786312, 12243.449044792984, 12745.872541274584, 12863.292518911456, 12891.355432228398, 12981.15622484539, 13621.387037583308, 13783.448662053532, 13796.93101534491, 13837.238951857644, 13854.792178117312, 614.6650075708727, 749.5165618176273, 753.8077790163528, 773.6131934032984, 783.34199272611, 782.4131901074194, 782.8943092682472, 784.051297929506, 785.579714852554, 785.6543121026758, 823.555280148722, 830.0869044051525, 830.4685001598981, 830.8172202115525, 830.8338332333527, 639.7760783725705, 658.1411258307907, 662.787907869482, 664.4617859533793, 823.2878560045577, 579.5798046416356, 595.1340799137245, 599.5653151465197, 600.1088383750127, 600.2616781358953, 12951.67620809478, 12981.350932453433, 13011.86988130116, 13092.86907130926, 13107.47570097195, 12239.571614993432, 12573.622791316275, 12799.168054076456, 13048.739025219538, 13495.325233738373, 11707.121965852595, 11832.112591555582, 11873.881261187364, 11980.34108124053, 12114.939425302817, 4083.4283200351974, 4165.75005499671, 4168.8332466701295, 4172.958270417287, 4174.540800511942, 61865.690671546356, 61878.381216187714, 61969.380306196814, 62390.37609623891, 62775.0, 10122.392656440637, 10325.896741032493, 10403.375797452178, 10510.947445262726, 10771.569137234423, 19061.90469047646, 19139.13873875679, 19323.4202973911, 19392.61214775725, 19413.126409311615, 6803.693833777492, 6912.516123871281, 6926.134233220848, 6943.375096241362, 7042.049323341385, 3745.981270093687, 3767.7174211933666, 3792.1846802937503, 3845.942310865339, 3878.2825177342283, 2537.7335379785227, 2635.235781623346, 2635.551956167456, 2642.0, 2646.325187077283, 444.78872535545355, 462.60216214055885, 467.2174108368469, 469.031450055634, 471.0202778221292, 497.35592407831945, 507.987300317495, 523.4765234765234, 533.5331584863245, 560.4367610551451, 7950.880736788953, 8050.235227653364, 8358.414910956297, 8482.957585212034, 8501.532415717194, 519.7271432497969, 531.7846272259741, 535.4484880573016, 547.4035586198715, 547.9506844384025, 3832.616738326201, 4128.422020917074, 4178.6657067434535, 4197.45433093702, 4241.597048280409, 100407.0, 104405.0, 106197.46901265444, 107857.4607126975, 107887.0, 92379.5381023104, 92591.53704231436, 93010.0, 94217.52891235637, 96109.0, 78983.60508197422, 80138.59930700426, 80548.59725701335, 80645.0, 80998.59500702577, 7582.696692132253, 7896.605169741605, 7976.441649084509, 8160.387970902325, 8183.3862460316905, 46445.76777116093, 46848.765756171, 48323.0, 48584.271235932196, 48589.27116093332, 65078.0, 69559.30440695529, 69692.0, 70438.64780676064, 71913.65122534038, 9924.851127233242, 9950.950245248727, 10087.646932357333, 10179.694609161737, 10242.846357304497, 10432.478376081317, 10563.0, 10959.56161753521, 11291.661250162508, 11341.036011938748, 8506.829863402822, 8675.436096653697, 8695.0, 8879.733607991771, 8993.55032248372, 9281.118293762082, 9360.812783744423, 9386.624535018524, 9390.107939745712, 9466.195373393339, 9848.310618256653, 9975.850362244428, 10101.14140298083, 10215.642452514126, 10322.071013608811, 8436.0, 8478.788030299293, 8498.0, 8837.293016558531, 8949.463032218087, 8296.37777166727, 8751.474911505331, 8804.163604457566, 8862.955685221532, 8965.462072275684], "value": 6402.735630581245, "unit": "score"}], "name": "dromaeo_css", "value": 6370.745786525926, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 113.0, 115.0, 113.0, 114.0, 113.0, 112.0, 113.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 122.0, 124.0, 185.0, 123.0, 122.0, 141.0, 121.0, 198.0, 127.0], "value": 142.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 160.0, 163.0, 162.0, 162.0, 160.0, 161.0, 163.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 100.0, 77.0, 77.0, 86.0, 75.0, 99.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 127.0, 85.0, 86.0, 86.0, 117.0, 86.0, 86.0, 130.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 147.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 62.0, 68.0, 65.0, 63.0, 63.0, 62.0, 63.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 69.0, 66.0, 65.0, 66.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 89.0, 85.0, 80.0, 88.0, 82.0, 79.0, 89.0, 85.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 130.0, 140.0, 134.0, 139.0, 129.0, 129.0, 129.0, 158.0, 137.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 180.0, 168.0, 165.0, 165.0, 167.0, 166.0, 166.0, 173.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 67.0, 67.0, 67.0, 72.0, 67.0, 66.0, 67.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1538.8999999999999, "alertThreshold": 2.0}]} 10:53:52 INFO - Return code: 0 10:53:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:53:52 INFO - # TBPL SUCCESS # 10:53:52 INFO - Running post-action listener: _resource_record_post_action 10:53:52 INFO - [mozharness: 2016-08-11 17:53:52.155338Z] Finished run-tests step (success) 10:53:52 INFO - Running post-run listener: _resource_record_post_run 10:53:52 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 537100288; Read time: 16; Write time: 461100 10:53:52 INFO - TinderboxPrint: CPU usage
13.0% 10:53:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:53:52 INFO - TinderboxPrint: I/O write bytes / time
537,100,288 / 461,100 10:53:52 INFO - TinderboxPrint: CPU idle
8,330.9 (87.0%) 10:53:52 INFO - TinderboxPrint: CPU user
1,202.8 (12.6%) 10:53:52 INFO - TinderboxPrint: Swap in / out
0 / 0 10:53:52 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252145664; Read time: 0; Write time: 250848 10:53:52 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 284954624; Read time: 0; Write time: 210252 10:53:52 INFO - Running post-run listener: _upload_blobber_files 10:53:52 INFO - Blob upload gear active. 10:53:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:53:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:53:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:53:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:53:53 INFO - (blobuploader) - INFO - Open directory for files ... 10:53:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:53:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:53:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:53:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:53:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:53:54 INFO - (blobuploader) - INFO - Done attempting. 10:53:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:53:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:53:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:54:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:54:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:54:01 INFO - (blobuploader) - INFO - Done attempting. 10:54:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:54:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:54:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:54:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:54:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:54:02 INFO - (blobuploader) - INFO - Done attempting. 10:54:02 INFO - (blobuploader) - INFO - Iteration through files over. 10:54:02 INFO - Return code: 0 10:54:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:54:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:54:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff4508af2b5c797301373845d03250b5aecc144ef1c1d14eb897569fe711b09b9b68f1c4fbd8d7d247396af1f72902505cfb580e03ec1e4de6f8b3314b1140b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f1d5a1291c2b8bb4ec47feeabb6b5608cbf962df54c5c3ddf0d8595bbebfe1e0e885964abb1e8406c4962d1649d8a4d56bbe3d33e11ae5d2afbafc32c967311", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a8b014eadd645701e6ae81476bb3ba0e8764a0dff5429288c621873875f6350c9e552fda8055119c5a48309d76bcf053e1ad04441c0d4ca374cca8f676076dee"} 10:54:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:54:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:54:02 INFO - Contents: 10:54:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff4508af2b5c797301373845d03250b5aecc144ef1c1d14eb897569fe711b09b9b68f1c4fbd8d7d247396af1f72902505cfb580e03ec1e4de6f8b3314b1140b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f1d5a1291c2b8bb4ec47feeabb6b5608cbf962df54c5c3ddf0d8595bbebfe1e0e885964abb1e8406c4962d1649d8a4d56bbe3d33e11ae5d2afbafc32c967311", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a8b014eadd645701e6ae81476bb3ba0e8764a0dff5429288c621873875f6350c9e552fda8055119c5a48309d76bcf053e1ad04441c0d4ca374cca8f676076dee"} 10:54:02 INFO - Running post-run listener: copy_logs_to_upload_dir 10:54:02 INFO - Copying logs to upload dir... 10:54:02 INFO - mkdir: /builds/slave/test/build/upload/logs 10:54:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.154828 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-11 10:54:01.774594) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 10:54:01.777844) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff4508af2b5c797301373845d03250b5aecc144ef1c1d14eb897569fe711b09b9b68f1c4fbd8d7d247396af1f72902505cfb580e03ec1e4de6f8b3314b1140b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f1d5a1291c2b8bb4ec47feeabb6b5608cbf962df54c5c3ddf0d8595bbebfe1e0e885964abb1e8406c4962d1649d8a4d56bbe3d33e11ae5d2afbafc32c967311", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a8b014eadd645701e6ae81476bb3ba0e8764a0dff5429288c621873875f6350c9e552fda8055119c5a48309d76bcf053e1ad04441c0d4ca374cca8f676076dee"} build_url:https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011478 build_url: 'https://queue.taskcluster.net/v1/task/aYe4Z6tsSJ2nXY5hQ9YXGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff4508af2b5c797301373845d03250b5aecc144ef1c1d14eb897569fe711b09b9b68f1c4fbd8d7d247396af1f72902505cfb580e03ec1e4de6f8b3314b1140b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f1d5a1291c2b8bb4ec47feeabb6b5608cbf962df54c5c3ddf0d8595bbebfe1e0e885964abb1e8406c4962d1649d8a4d56bbe3d33e11ae5d2afbafc32c967311", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a8b014eadd645701e6ae81476bb3ba0e8764a0dff5429288c621873875f6350c9e552fda8055119c5a48309d76bcf053e1ad04441c0d4ca374cca8f676076dee"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 10:54:01.803491) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 10:54:01.803813) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1470936799.374000-2144293085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 10:54:01.888095) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 10:54:01.888649) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 10:54:01.889199) ========= ========= Total master_lag: 0.17 =========