builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1470330297.27 results: success (0) buildid: 20160804092622 builduid: 1138ca26c8844dbcbb8fe3de05954448 revision: 5ad07719e3bdf424673e7f1c7d0e0dc9b6880cae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 10:04:57.274726) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 10:04:57.275371) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 10:04:57.275648) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 10:04:57.307620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:04:57.307884) ========= 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=20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 10:04:57-- 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% 70.8M=0s 2016-08-04 10:04:57 (70.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115570 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:04:57.437513) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:04:57.437825) ========= 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=20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014314 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:04:57.488314) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:04:57.488744) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5ad07719e3bdf424673e7f1c7d0e0dc9b6880cae --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 5ad07719e3bdf424673e7f1c7d0e0dc9b6880cae --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=20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 10:04:57,677 truncating revision to first 12 chars 2016-08-04 10:04:57,678 Setting DEBUG logging. 2016-08-04 10:04:57,678 attempt 1/10 2016-08-04 10:04:57,678 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5ad07719e3bd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 10:04:58,292 unpacking tar archive at: fx-team-5ad07719e3bd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.945798 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:04:58.449112) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 10:04:58.449406) ========= script_repo_revision: 5ad07719e3bdf424673e7f1c7d0e0dc9b6880cae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 10:04:58.449792) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 10:04:58.450055) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 10:04:58.460927) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-04 10:04:58.461243) ========= /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=20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:04:58 INFO - MultiFileLogger online at 20160804 10:04:58 in /builds/slave/test 10:04:58 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:04:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:04:58 INFO - {'append_to_log': False, 10:04:58 INFO - 'base_work_dir': '/builds/slave/test', 10:04:58 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:04:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:04:58 INFO - 'branch': 'Fx-Team-Non-PGO', 10:04:58 INFO - 'buildbot_json_path': 'buildprops.json', 10:04:58 INFO - 'config_files': ('talos/linux_config.py',), 10:04:58 INFO - 'default_actions': ('clobber', 10:04:58 INFO - 'read-buildbot-config', 10:04:58 INFO - 'download-and-extract', 10:04:58 INFO - 'populate-webroot', 10:04:58 INFO - 'create-virtualenv', 10:04:58 INFO - 'install', 10:04:58 INFO - 'run-tests'), 10:04:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:04:58 INFO - 'download_minidump_stackwalk': True, 10:04:58 INFO - 'download_symbols': 'ondemand', 10:04:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:04:58 INFO - 'tooltool.py': '/tools/tooltool.py', 10:04:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:04:58 INFO - '/tools/misc-python/virtualenv.py')}, 10:04:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:04:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:04:58 INFO - 'installer_path': 'installer.exe', 10:04:58 INFO - 'log_level': 'info', 10:04:58 INFO - 'log_name': 'talos', 10:04:58 INFO - 'log_to_console': True, 10:04:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:04:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:04:58 INFO - 'opt_config_files': (), 10:04:58 INFO - 'pip_index': False, 10:04:58 INFO - 'sps_profile': False, 10:04:58 INFO - 'sps_profile_interval': 0, 10:04:58 INFO - 'suite': 'dromaeojs', 10:04:58 INFO - 'system_bits': '32', 10:04:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:04:58 INFO - 'title': 'talos-linux64-ix-015', 10:04:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:04:58 INFO - 'use_talos_json': True, 10:04:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:04:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:04:58 INFO - 'work_dir': 'build'} 10:04:58 INFO - [mozharness: 2016-08-04 17:04:58.733998Z] Running clobber step. 10:04:58 INFO - Running pre-action listener: _resource_record_pre_action 10:04:58 INFO - Running main action method: clobber 10:04:58 INFO - rmtree: /builds/slave/test/build 10:04:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:04:59 INFO - Running post-action listener: _resource_record_post_action 10:04:59 INFO - [mozharness: 2016-08-04 17:04:59.695700Z] Finished clobber step (success) 10:04:59 INFO - [mozharness: 2016-08-04 17:04:59.695800Z] Running read-buildbot-config step. 10:04:59 INFO - Running pre-action listener: _resource_record_pre_action 10:04:59 INFO - Running main action method: read_buildbot_config 10:04:59 INFO - Using buildbot properties: 10:04:59 INFO - { 10:04:59 INFO - "project": "", 10:04:59 INFO - "product": "firefox", 10:04:59 INFO - "script_repo_revision": "production", 10:04:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:04:59 INFO - "repository": "", 10:04:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:04:59 INFO - "buildid": "20160804092622", 10:04:59 INFO - "pgo_build": "False", 10:04:59 INFO - "basedir": "/builds/slave/test", 10:04:59 INFO - "buildnumber": 3211, 10:04:59 INFO - "slavename": "talos-linux64-ix-015", 10:04:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:04:59 INFO - "platform": "ubuntu64_hw", 10:04:59 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:04:59 INFO - "branch": "fx-team", 10:04:59 INFO - "repo_path": "integration/fx-team", 10:04:59 INFO - "revision": "5ad07719e3bdf424673e7f1c7d0e0dc9b6880cae", 10:04:59 INFO - "stage_platform": "linux64", 10:04:59 INFO - "builduid": "1138ca26c8844dbcbb8fe3de05954448", 10:04:59 INFO - "slavebuilddir": "test" 10:04:59 INFO - } 10:04:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/QjP6aVfAQqeZ8IyA8y7yDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:04:59 INFO - Running post-action listener: _resource_record_post_action 10:04:59 INFO - [mozharness: 2016-08-04 17:04:59.698242Z] Finished read-buildbot-config step (success) 10:04:59 INFO - [mozharness: 2016-08-04 17:04:59.698331Z] Running download-and-extract step. 10:04:59 INFO - Running pre-action listener: _resource_record_pre_action 10:04:59 INFO - Running main action method: download_and_extract 10:04:59 INFO - mkdir: /builds/slave/test/build/tests 10:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:04:59 INFO - trying https://queue.taskcluster.net/v1/task/QjP6aVfAQqeZ8IyA8y7yDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:04:59 INFO - Downloading https://queue.taskcluster.net/v1/task/QjP6aVfAQqeZ8IyA8y7yDA/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:04:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QjP6aVfAQqeZ8IyA8y7yDA/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:05:00 INFO - Downloaded 1361 bytes. 10:05:00 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:05:00 INFO - Using the following test package requirements: 10:05:00 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:05:00 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:05:00 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:05:00 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:00 INFO - u'jsshell-linux-x86_64.zip'], 10:05:00 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:05:00 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:05:00 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:05:00 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:05:00 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:05:00 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:05:00 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:00 INFO - trying https://queue.taskcluster.net/v1/task/QjP6aVfAQqeZ8IyA8y7yDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:05:00 INFO - Downloading https://queue.taskcluster.net/v1/task/QjP6aVfAQqeZ8IyA8y7yDA/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:05:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QjP6aVfAQqeZ8IyA8y7yDA/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:05:01 INFO - Downloaded 20249167 bytes. 10:05:01 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:05:01 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:05:02 INFO - Return code: 0 10:05:02 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:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:02 INFO - trying https://queue.taskcluster.net/v1/task/QjP6aVfAQqeZ8IyA8y7yDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:05:02 INFO - Downloading https://queue.taskcluster.net/v1/task/QjP6aVfAQqeZ8IyA8y7yDA/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:05:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QjP6aVfAQqeZ8IyA8y7yDA/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:05:03 INFO - Downloaded 20249167 bytes. 10:05:03 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:05:03 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:05:04 INFO - Return code: 0 10:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:04 INFO - trying https://queue.taskcluster.net/v1/task/QjP6aVfAQqeZ8IyA8y7yDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:05:04 INFO - Downloading https://queue.taskcluster.net/v1/task/QjP6aVfAQqeZ8IyA8y7yDA/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:05:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QjP6aVfAQqeZ8IyA8y7yDA/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:05:05 INFO - Downloaded 14413723 bytes. 10:05:05 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:05:05 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:05:06 INFO - Return code: 0 10:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:06 INFO - trying https://queue.taskcluster.net/v1/task/QjP6aVfAQqeZ8IyA8y7yDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:05:06 INFO - Downloading https://queue.taskcluster.net/v1/task/QjP6aVfAQqeZ8IyA8y7yDA/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:05:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QjP6aVfAQqeZ8IyA8y7yDA/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:05:10 INFO - Downloaded 55515117 bytes. 10:05:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QjP6aVfAQqeZ8IyA8y7yDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:05:10 INFO - mkdir: /builds/slave/test/properties 10:05:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:05:10 INFO - Writing to file /builds/slave/test/properties/build_url 10:05:10 INFO - Contents: 10:05:10 INFO - build_url:https://queue.taskcluster.net/v1/task/QjP6aVfAQqeZ8IyA8y7yDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:05:11 INFO - Running post-action listener: _resource_record_post_action 10:05:11 INFO - Running post-action listener: set_extra_try_arguments 10:05:11 INFO - [mozharness: 2016-08-04 17:05:11.060211Z] Finished download-and-extract step (success) 10:05:11 INFO - [mozharness: 2016-08-04 17:05:11.060443Z] Running populate-webroot step. 10:05:11 INFO - Running pre-action listener: _resource_record_pre_action 10:05:11 INFO - Running main action method: populate_webroot 10:05:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:05:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:05:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:05:11 INFO - '--tppagecycles', 10:05:11 INFO - '7'], 10:05:11 INFO - 'tests': ['tsvgm']}}, 10:05:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:05:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:05:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:05:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:05:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:05:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:05:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:11 INFO - 'talos_options': ['--disable-e10s'], 10:05:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:11 INFO - 'talos_options': ['--disable-e10s'], 10:05:11 INFO - 'tests': ['damp', 'tps']}, 10:05:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:11 INFO - 'tests': ['damp', 'tps']}, 10:05:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:05:11 INFO - 'tests': ['dromaeo_dom']}, 10:05:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:05:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:05:11 INFO - 'tests': ['basic_compositor_video']}, 10:05:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:05:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:05:11 INFO - 'tests': ['a11yr', 10:05:11 INFO - 'ts_paint', 10:05:11 INFO - 'tpaint', 10:05:11 INFO - 'sessionrestore', 10:05:11 INFO - 'sessionrestore_no_auto_restore', 10:05:11 INFO - 'tabpaint']}, 10:05:11 INFO - 'other-e10s': {'tests': ['a11yr', 10:05:11 INFO - 'ts_paint', 10:05:11 INFO - 'tpaint', 10:05:11 INFO - 'sessionrestore', 10:05:11 INFO - 'sessionrestore_no_auto_restore', 10:05:11 INFO - 'tabpaint']}, 10:05:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:05:11 INFO - 'ts_paint', 10:05:11 INFO - 'tpaint', 10:05:11 INFO - 'sessionrestore', 10:05:11 INFO - 'sessionrestore_no_auto_restore', 10:05:11 INFO - 'tabpaint']}, 10:05:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:05:11 INFO - 'ts_paint', 10:05:11 INFO - 'tpaint', 10:05:11 INFO - 'sessionrestore', 10:05:11 INFO - 'sessionrestore_no_auto_restore', 10:05:11 INFO - 'tabpaint']}, 10:05:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:05:11 INFO - 'tests': ['a11yr', 10:05:11 INFO - 'ts_paint', 10:05:11 INFO - 'tpaint', 10:05:11 INFO - 'sessionrestore', 10:05:11 INFO - 'sessionrestore_no_auto_restore', 10:05:11 INFO - 'tabpaint']}, 10:05:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:05:11 INFO - 'tests': ['a11yr', 10:05:11 INFO - 'ts_paint', 10:05:11 INFO - 'tpaint', 10:05:11 INFO - 'sessionrestore', 10:05:11 INFO - 'sessionrestore_no_auto_restore', 10:05:11 INFO - 'tabpaint']}, 10:05:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:05:11 INFO - 'tests': ['tsvgx', 10:05:11 INFO - 'tsvgr_opacity', 10:05:11 INFO - 'tart', 10:05:11 INFO - 'tscrollx', 10:05:11 INFO - 'cart']}, 10:05:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:05:11 INFO - 'tsvgr_opacity', 10:05:11 INFO - 'tart', 10:05:11 INFO - 'tscrollx', 10:05:11 INFO - 'cart']}, 10:05:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:11 INFO - 'talos_options': ['--disable-e10s'], 10:05:11 INFO - 'tests': ['tp5o']}, 10:05:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:11 INFO - 'tests': ['tp5o']}, 10:05:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:11 INFO - 'talos_options': ['--disable-e10s', 10:05:11 INFO - '--xperf_path', 10:05:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:11 INFO - 'tests': ['tp5n']}, 10:05:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:11 INFO - 'talos_options': ['--xperf_path', 10:05:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:11 INFO - 'tests': ['tp5n']}}, 10:05:11 INFO - 'talos.zip': {'path': '', 10:05:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:05:11 INFO - Running post-action listener: _resource_record_post_action 10:05:11 INFO - [mozharness: 2016-08-04 17:05:11.076733Z] Finished populate-webroot step (success) 10:05:11 INFO - [mozharness: 2016-08-04 17:05:11.076821Z] Running create-virtualenv step. 10:05:11 INFO - Running pre-action listener: _resource_record_pre_action 10:05:11 INFO - Running main action method: create_virtualenv 10:05:11 INFO - Creating virtualenv /builds/slave/test/build/venv 10:05:11 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:05:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:05:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:05:11 INFO - Using real prefix '/usr' 10:05:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:05:11 INFO - Installing distribute.............................................................................................................................................................................................done. 10:05:13 INFO - Installing pip.................done. 10:05:13 INFO - Return code: 0 10:05:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:13 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 0x24fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bb3b0>, '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 0x27bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360', '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:05:13 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:05:13 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:05:13 INFO - Using env: {'DISPLAY': ':0', 10:05:13 INFO - 'HOME': '/home/cltbld', 10:05:13 INFO - 'LANG': 'en_US.UTF-8', 10:05:13 INFO - 'LANGUAGE': 'en_US:en', 10:05:13 INFO - 'LOGNAME': 'cltbld', 10:05:13 INFO - 'MAIL': '/var/mail/cltbld', 10:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:13 INFO - 'MOZ_NO_REMOTE': '1', 10:05:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:13 INFO - 'NO_EM_RESTART': '1', 10:05:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:13 INFO - 'PWD': '/builds/slave/test', 10:05:13 INFO - 'SHELL': '/bin/bash', 10:05:13 INFO - 'SHLVL': '1', 10:05:13 INFO - 'TERM': 'linux', 10:05:13 INFO - 'TMOUT': '86400', 10:05:13 INFO - 'USER': 'cltbld', 10:05:13 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360', 10:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:13 INFO - '_': '/tools/buildbot/bin/python'} 10:05:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:13 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:05:13 INFO - Cleaning up... 10:05:13 INFO - Return code: 0 10:05:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:13 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 0x24fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bb3b0>, '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 0x27bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360', '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:05:13 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:05:13 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:05:13 INFO - Using env: {'DISPLAY': ':0', 10:05:13 INFO - 'HOME': '/home/cltbld', 10:05:13 INFO - 'LANG': 'en_US.UTF-8', 10:05:13 INFO - 'LANGUAGE': 'en_US:en', 10:05:13 INFO - 'LOGNAME': 'cltbld', 10:05:13 INFO - 'MAIL': '/var/mail/cltbld', 10:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:13 INFO - 'MOZ_NO_REMOTE': '1', 10:05:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:13 INFO - 'NO_EM_RESTART': '1', 10:05:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:13 INFO - 'PWD': '/builds/slave/test', 10:05:13 INFO - 'SHELL': '/bin/bash', 10:05:13 INFO - 'SHLVL': '1', 10:05:13 INFO - 'TERM': 'linux', 10:05:13 INFO - 'TMOUT': '86400', 10:05:13 INFO - 'USER': 'cltbld', 10:05:13 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360', 10:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:13 INFO - '_': '/tools/buildbot/bin/python'} 10:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:14 INFO - Downloading/unpacking psutil>=3.1.1 10:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:05:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:16 INFO - Installing collected packages: psutil 10:05:16 INFO - Running setup.py install for psutil 10:05:16 INFO - building 'psutil._psutil_linux' extension 10:05:16 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:05:16 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:05:16 INFO - building 'psutil._psutil_posix' extension 10:05:16 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:05:16 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:05:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:16 INFO - Successfully installed psutil 10:05:16 INFO - Cleaning up... 10:05:16 INFO - Return code: 0 10:05:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:16 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 0x24fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bb3b0>, '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 0x27bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360', '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:05:16 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:05:16 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:05:16 INFO - Using env: {'DISPLAY': ':0', 10:05:16 INFO - 'HOME': '/home/cltbld', 10:05:16 INFO - 'LANG': 'en_US.UTF-8', 10:05:16 INFO - 'LANGUAGE': 'en_US:en', 10:05:16 INFO - 'LOGNAME': 'cltbld', 10:05:16 INFO - 'MAIL': '/var/mail/cltbld', 10:05:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:16 INFO - 'MOZ_NO_REMOTE': '1', 10:05:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:16 INFO - 'NO_EM_RESTART': '1', 10:05:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:16 INFO - 'PWD': '/builds/slave/test', 10:05:16 INFO - 'SHELL': '/bin/bash', 10:05:16 INFO - 'SHLVL': '1', 10:05:16 INFO - 'TERM': 'linux', 10:05:16 INFO - 'TMOUT': '86400', 10:05:16 INFO - 'USER': 'cltbld', 10:05:16 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360', 10:05:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:16 INFO - '_': '/tools/buildbot/bin/python'} 10:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:05:16 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:05:16 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:05:16 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:05:16 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:05:16 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:05:16 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:05:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:05:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:05:18 INFO - Installing collected packages: mozsystemmonitor 10:05:18 INFO - Running setup.py install for mozsystemmonitor 10:05:18 INFO - Successfully installed mozsystemmonitor 10:05:18 INFO - Cleaning up... 10:05:18 INFO - Return code: 0 10:05:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:05:18 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:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:18 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:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:18 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 0x24fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bb3b0>, '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 0x27bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360', '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:05:18 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:05:18 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:05:18 INFO - Using env: {'DISPLAY': ':0', 10:05:18 INFO - 'HOME': '/home/cltbld', 10:05:18 INFO - 'LANG': 'en_US.UTF-8', 10:05:18 INFO - 'LANGUAGE': 'en_US:en', 10:05:18 INFO - 'LOGNAME': 'cltbld', 10:05:18 INFO - 'MAIL': '/var/mail/cltbld', 10:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:18 INFO - 'MOZ_NO_REMOTE': '1', 10:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:18 INFO - 'NO_EM_RESTART': '1', 10:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:18 INFO - 'PWD': '/builds/slave/test', 10:05:18 INFO - 'SHELL': '/bin/bash', 10:05:18 INFO - 'SHLVL': '1', 10:05:18 INFO - 'TERM': 'linux', 10:05:18 INFO - 'TMOUT': '86400', 10:05:18 INFO - 'USER': 'cltbld', 10:05:18 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360', 10:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:18 INFO - '_': '/tools/buildbot/bin/python'} 10:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:19 INFO - Downloading/unpacking jsonschema==2.5.1 10:05:19 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:05:19 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:05:19 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:05:19 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:05:19 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:05:19 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:05:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:05:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:05:20 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:05:20 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:05:20 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:05:20 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:05:20 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:05:20 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:05:21 INFO - Downloading functools32-3.2.3-2.tar.gz 10:05:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:05:21 INFO - warning: no files found matching '*.txt' 10:05:21 INFO - no previously-included directories found matching 'build' 10:05:21 INFO - no previously-included directories found matching 'dist' 10:05:21 INFO - no previously-included directories found matching '.git*' 10:05:21 INFO - Installing collected packages: jsonschema, functools32 10:05:21 INFO - Running setup.py install for functools32 10:05:21 INFO - warning: no files found matching '*.txt' 10:05:21 INFO - no previously-included directories found matching 'build' 10:05:21 INFO - no previously-included directories found matching 'dist' 10:05:21 INFO - no previously-included directories found matching '.git*' 10:05:21 INFO - Successfully installed jsonschema functools32 10:05:21 INFO - Cleaning up... 10:05:21 INFO - Return code: 0 10:05:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:05: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:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:21 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 0x24fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bb3b0>, '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 0x27bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360', '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:05:21 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:05:21 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:05:21 INFO - Using env: {'DISPLAY': ':0', 10:05:21 INFO - 'HOME': '/home/cltbld', 10:05:21 INFO - 'LANG': 'en_US.UTF-8', 10:05:21 INFO - 'LANGUAGE': 'en_US:en', 10:05:21 INFO - 'LOGNAME': 'cltbld', 10:05:21 INFO - 'MAIL': '/var/mail/cltbld', 10:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:21 INFO - 'MOZ_NO_REMOTE': '1', 10:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:21 INFO - 'NO_EM_RESTART': '1', 10:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:21 INFO - 'PWD': '/builds/slave/test', 10:05:21 INFO - 'SHELL': '/bin/bash', 10:05:21 INFO - 'SHLVL': '1', 10:05:21 INFO - 'TERM': 'linux', 10:05:21 INFO - 'TMOUT': '86400', 10:05:21 INFO - 'USER': 'cltbld', 10:05:21 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360', 10:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:21 INFO - '_': '/tools/buildbot/bin/python'} 10:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:05:21 INFO - Cleaning up... 10:05:21 INFO - Return code: 0 10:05:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:05: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:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:21 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 0x24fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bb3b0>, '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 0x27bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360', '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:05:21 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:05:21 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:05:21 INFO - Using env: {'DISPLAY': ':0', 10:05:21 INFO - 'HOME': '/home/cltbld', 10:05:21 INFO - 'LANG': 'en_US.UTF-8', 10:05:21 INFO - 'LANGUAGE': 'en_US:en', 10:05:21 INFO - 'LOGNAME': 'cltbld', 10:05:21 INFO - 'MAIL': '/var/mail/cltbld', 10:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:21 INFO - 'MOZ_NO_REMOTE': '1', 10:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:21 INFO - 'NO_EM_RESTART': '1', 10:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:21 INFO - 'PWD': '/builds/slave/test', 10:05:21 INFO - 'SHELL': '/bin/bash', 10:05:21 INFO - 'SHLVL': '1', 10:05:21 INFO - 'TERM': 'linux', 10:05:21 INFO - 'TMOUT': '86400', 10:05:21 INFO - 'USER': 'cltbld', 10:05:21 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360', 10:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:21 INFO - '_': '/tools/buildbot/bin/python'} 10:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:21 INFO - Downloading/unpacking blobuploader==1.2.4 10:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:23 INFO - Downloading blobuploader-1.2.4.tar.gz 10:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:05:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:05:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:05:24 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:05:24 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:05:24 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:05:24 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:05:24 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:05:24 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:05:24 INFO - Downloading docopt-0.6.1.tar.gz 10:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:05:24 INFO - Installing collected packages: blobuploader, requests, docopt 10:05:24 INFO - Running setup.py install for blobuploader 10:05:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:05:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:05:24 INFO - Running setup.py install for requests 10:05:24 INFO - Running setup.py install for docopt 10:05:25 INFO - Successfully installed blobuploader requests docopt 10:05:25 INFO - Cleaning up... 10:05:25 INFO - Return code: 0 10:05:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:25 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:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:25 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:05:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:25 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 0x24fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bb3b0>, '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 0x27bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360', '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:05:25 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:05:25 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:05:25 INFO - Using env: {'DISPLAY': ':0', 10:05:25 INFO - 'HOME': '/home/cltbld', 10:05:25 INFO - 'LANG': 'en_US.UTF-8', 10:05:25 INFO - 'LANGUAGE': 'en_US:en', 10:05:25 INFO - 'LOGNAME': 'cltbld', 10:05:25 INFO - 'MAIL': '/var/mail/cltbld', 10:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:25 INFO - 'MOZ_NO_REMOTE': '1', 10:05:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:25 INFO - 'NO_EM_RESTART': '1', 10:05:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:25 INFO - 'PWD': '/builds/slave/test', 10:05:25 INFO - 'SHELL': '/bin/bash', 10:05:25 INFO - 'SHLVL': '1', 10:05:25 INFO - 'TERM': 'linux', 10:05:25 INFO - 'TMOUT': '86400', 10:05:25 INFO - 'USER': 'cltbld', 10:05:25 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360', 10:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:25 INFO - '_': '/tools/buildbot/bin/python'} 10:05:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:25 INFO - Running setup.py (path:/tmp/pip-dVDi9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:25 INFO - Running setup.py (path:/tmp/pip-CYPQ1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:25 INFO - Running setup.py (path:/tmp/pip-vLOnDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:25 INFO - Running setup.py (path:/tmp/pip-OwFAaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:25 INFO - Running setup.py (path:/tmp/pip-TfMtdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:25 INFO - Running setup.py (path:/tmp/pip-59xayX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:25 INFO - Running setup.py (path:/tmp/pip-658L_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:25 INFO - Running setup.py (path:/tmp/pip-Rz4vvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:25 INFO - Running setup.py (path:/tmp/pip-nxzkhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:26 INFO - Running setup.py (path:/tmp/pip-BtIYf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:26 INFO - Running setup.py (path:/tmp/pip-jhvjQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:26 INFO - Running setup.py (path:/tmp/pip-OATYpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:26 INFO - Running setup.py (path:/tmp/pip-t38M08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:26 INFO - Running setup.py (path:/tmp/pip-jwlL12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:26 INFO - Running setup.py (path:/tmp/pip-7iMMoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:26 INFO - Running setup.py (path:/tmp/pip-SSHbEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:26 INFO - Running setup.py (path:/tmp/pip-WEk7Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:05:26 INFO - Running setup.py install for manifestparser 10:05:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:05:26 INFO - Running setup.py install for mozcrash 10:05:26 INFO - Running setup.py install for mozdebug 10:05:26 INFO - Running setup.py install for mozdevice 10:05:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:05:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:05:27 INFO - Running setup.py install for mozfile 10:05:27 INFO - Running setup.py install for mozhttpd 10:05:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:05:27 INFO - Running setup.py install for mozinfo 10:05:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:05:27 INFO - Running setup.py install for mozInstall 10:05:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:05:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:05:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:05:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:05:27 INFO - Running setup.py install for mozleak 10:05:27 INFO - Running setup.py install for mozlog 10:05:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:05:27 INFO - Running setup.py install for moznetwork 10:05:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:05:27 INFO - Running setup.py install for mozprocess 10:05:27 INFO - Running setup.py install for mozprofile 10:05:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:05:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:05:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:05:27 INFO - Running setup.py install for mozrunner 10:05:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:05:28 INFO - Running setup.py install for mozscreenshot 10:05:28 INFO - Running setup.py install for moztest 10:05:28 INFO - Running setup.py install for mozversion 10:05:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:05:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:05:28 INFO - Cleaning up... 10:05:28 INFO - Return code: 0 10:05:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:28 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 0x24fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bb3b0>, '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 0x27bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360', '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:05:28 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:05:28 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:05:28 INFO - Using env: {'DISPLAY': ':0', 10:05:28 INFO - 'HOME': '/home/cltbld', 10:05:28 INFO - 'LANG': 'en_US.UTF-8', 10:05:28 INFO - 'LANGUAGE': 'en_US:en', 10:05:28 INFO - 'LOGNAME': 'cltbld', 10:05:28 INFO - 'MAIL': '/var/mail/cltbld', 10:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:28 INFO - 'MOZ_NO_REMOTE': '1', 10:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:28 INFO - 'NO_EM_RESTART': '1', 10:05:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:28 INFO - 'PWD': '/builds/slave/test', 10:05:28 INFO - 'SHELL': '/bin/bash', 10:05:28 INFO - 'SHLVL': '1', 10:05:28 INFO - 'TERM': 'linux', 10:05:28 INFO - 'TMOUT': '86400', 10:05:28 INFO - 'USER': 'cltbld', 10:05:28 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360', 10:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:28 INFO - '_': '/tools/buildbot/bin/python'} 10:05:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:28 INFO - Running setup.py (path:/tmp/pip-WoEzts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:28 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:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:28 INFO - Running setup.py (path:/tmp/pip-ZHCdQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:28 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:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:28 INFO - Running setup.py (path:/tmp/pip-2db5R4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:28 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:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:28 INFO - Running setup.py (path:/tmp/pip-Uy2zQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:28 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:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:28 INFO - Running setup.py (path:/tmp/pip-R7ZkPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:28 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:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:28 INFO - Running setup.py (path:/tmp/pip-Oq6sPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:29 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:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:29 INFO - Running setup.py (path:/tmp/pip-3vrpb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:29 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:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:29 INFO - Running setup.py (path:/tmp/pip-bFe_ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:29 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:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:29 INFO - Running setup.py (path:/tmp/pip-6kLKhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:29 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:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:29 INFO - Running setup.py (path:/tmp/pip-zZa2bY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:29 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:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:29 INFO - Running setup.py (path:/tmp/pip-aI3bTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:29 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:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:29 INFO - Running setup.py (path:/tmp/pip-Q5_hck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:29 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:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:29 INFO - Running setup.py (path:/tmp/pip-O_Cxsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:29 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:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:29 INFO - Running setup.py (path:/tmp/pip-71ln0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:29 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:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:29 INFO - Running setup.py (path:/tmp/pip-DYAO5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:29 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:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:29 INFO - Running setup.py (path:/tmp/pip-GbYj3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:29 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:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:29 INFO - Running setup.py (path:/tmp/pip-lek1VD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:29 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:05:29 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:05:29 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:05:29 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:05:29 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:05:29 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:05:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:05:29 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:05:29 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:05:29 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:05:29 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:05:29 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:05:29 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:05:31 INFO - Downloading blessings-1.6.tar.gz 10:05:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:05:31 INFO - Installing collected packages: blessings 10:05:31 INFO - Running setup.py install for blessings 10:05:31 INFO - Successfully installed blessings 10:05:31 INFO - Cleaning up... 10:05:31 INFO - Return code: 0 10:05:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:05:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:32 INFO - Reading from file tmpfile_stdout 10:05:32 INFO - Current package versions: 10:05:32 INFO - argparse == 1.2.1 10:05:32 INFO - blessings == 1.6 10:05:32 INFO - blobuploader == 1.2.4 10:05:32 INFO - docopt == 0.6.1 10:05:32 INFO - functools32 == 3.2.3-2 10:05:32 INFO - jsonschema == 2.5.1 10:05:32 INFO - manifestparser == 1.1 10:05:32 INFO - mozInstall == 1.12 10:05:32 INFO - mozcrash == 0.17 10:05:32 INFO - mozdebug == 0.1 10:05:32 INFO - mozdevice == 0.48 10:05:32 INFO - mozfile == 1.2 10:05:32 INFO - mozhttpd == 0.7 10:05:32 INFO - mozinfo == 0.9 10:05:32 INFO - mozleak == 0.1 10:05:32 INFO - mozlog == 3.3 10:05:32 INFO - moznetwork == 0.27 10:05:32 INFO - mozprocess == 0.23 10:05:32 INFO - mozprofile == 0.28 10:05:32 INFO - mozrunner == 6.12 10:05:32 INFO - mozscreenshot == 0.1 10:05:32 INFO - mozsystemmonitor == 0.3 10:05:32 INFO - moztest == 0.7 10:05:32 INFO - mozversion == 1.4 10:05:32 INFO - psutil == 3.1.1 10:05:32 INFO - requests == 1.2.3 10:05:32 INFO - wsgiref == 0.1.2 10:05:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05: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:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:32 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 0x24fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bb3b0>, '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 0x27bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360', '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:05:32 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:05:32 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:05:32 INFO - Using env: {'DISPLAY': ':0', 10:05:32 INFO - 'HOME': '/home/cltbld', 10:05:32 INFO - 'LANG': 'en_US.UTF-8', 10:05:32 INFO - 'LANGUAGE': 'en_US:en', 10:05:32 INFO - 'LOGNAME': 'cltbld', 10:05:32 INFO - 'MAIL': '/var/mail/cltbld', 10:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:32 INFO - 'MOZ_NO_REMOTE': '1', 10:05:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:32 INFO - 'NO_EM_RESTART': '1', 10:05:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:32 INFO - 'PWD': '/builds/slave/test', 10:05:32 INFO - 'SHELL': '/bin/bash', 10:05:32 INFO - 'SHLVL': '1', 10:05:32 INFO - 'TERM': 'linux', 10:05:32 INFO - 'TMOUT': '86400', 10:05:32 INFO - 'USER': 'cltbld', 10:05:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360', 10:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:32 INFO - '_': '/tools/buildbot/bin/python'} 10:05:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:32 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:05:32 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:05:32 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:05:32 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:05:32 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:05:32 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:05:32 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:05:32 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:05:32 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:05:32 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:05:32 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:05:32 INFO - Cleaning up... 10:05:32 INFO - Return code: 0 10:05:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:05: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:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bb3b0>, '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 0x27bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360', '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:05: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', 'jsonschema'] in /builds/slave/test/build 10:05: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 jsonschema 10:05:32 INFO - Using env: {'DISPLAY': ':0', 10:05:32 INFO - 'HOME': '/home/cltbld', 10:05:32 INFO - 'LANG': 'en_US.UTF-8', 10:05:32 INFO - 'LANGUAGE': 'en_US:en', 10:05:32 INFO - 'LOGNAME': 'cltbld', 10:05:32 INFO - 'MAIL': '/var/mail/cltbld', 10:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:32 INFO - 'MOZ_NO_REMOTE': '1', 10:05:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:32 INFO - 'NO_EM_RESTART': '1', 10:05:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:32 INFO - 'PWD': '/builds/slave/test', 10:05:32 INFO - 'SHELL': '/bin/bash', 10:05:32 INFO - 'SHLVL': '1', 10:05:32 INFO - 'TERM': 'linux', 10:05:32 INFO - 'TMOUT': '86400', 10:05:32 INFO - 'USER': 'cltbld', 10:05:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360', 10:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:32 INFO - '_': '/tools/buildbot/bin/python'} 10:05:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:05:32 INFO - Cleaning up... 10:05:32 INFO - Return code: 0 10:05:32 INFO - Running post-action listener: _resource_record_post_action 10:05:32 INFO - Running post-action listener: _start_resource_monitoring 10:05:32 INFO - Starting resource monitoring. 10:05:32 INFO - [mozharness: 2016-08-04 17:05:32.665955Z] Finished create-virtualenv step (success) 10:05:32 INFO - [mozharness: 2016-08-04 17:05:32.666451Z] Running install step. 10:05:32 INFO - Running pre-action listener: _resource_record_pre_action 10:05:32 INFO - Running main action method: install 10:05:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:32 INFO - Reading from file tmpfile_stdout 10:05:32 INFO - Detecting whether we're running mozinstall >=1.0... 10:05:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:05:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:05:32 INFO - Reading from file tmpfile_stdout 10:05:32 INFO - Output received: 10:05:32 INFO - Usage: mozinstall [options] installer 10:05:32 INFO - Options: 10:05:32 INFO - -h, --help show this help message and exit 10:05:32 INFO - -d DEST, --destination=DEST 10:05:32 INFO - Directory to install application into. [default: 10:05:32 INFO - "/builds/slave/test"] 10:05:32 INFO - --app=APP Application being installed. [default: firefox] 10:05:32 INFO - mkdir: /builds/slave/test/build/application 10:05:32 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:05:32 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:05:48 INFO - Reading from file tmpfile_stdout 10:05:48 INFO - Output received: 10:05:48 INFO - /builds/slave/test/build/application/firefox/firefox 10:05:48 INFO - Running post-action listener: _resource_record_post_action 10:05:48 INFO - [mozharness: 2016-08-04 17:05:48.937258Z] Finished install step (success) 10:05:48 INFO - [mozharness: 2016-08-04 17:05:48.937506Z] Running run-tests step. 10:05:48 INFO - Running pre-action listener: _resource_record_pre_action 10:05:48 INFO - Running main action method: run_tests 10:05:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:05:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:05:48 INFO - Python 2.7.3 10:05:48 INFO - Return code: 0 10:05:48 INFO - grabbing minidump binary from tooltool 10:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:48 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 0x27bb3b0>, '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 0x27bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:05:48 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:05:48 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:05:48 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:05:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:05:49 INFO - Return code: 0 10:05:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:05:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:05:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:05:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:05:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:05:49 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/QjP6aVfAQqeZ8IyA8y7yDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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:05:49 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/QjP6aVfAQqeZ8IyA8y7yDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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:05:49 INFO - Using env: {'DISPLAY': ':0', 10:05:49 INFO - 'HOME': '/home/cltbld', 10:05:49 INFO - 'LANG': 'en_US.UTF-8', 10:05:49 INFO - 'LANGUAGE': 'en_US:en', 10:05:49 INFO - 'LOGNAME': 'cltbld', 10:05:49 INFO - 'MAIL': '/var/mail/cltbld', 10:05:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:05:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:49 INFO - 'MOZ_NO_REMOTE': '1', 10:05:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:49 INFO - 'NO_EM_RESTART': '1', 10:05:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:49 INFO - 'PWD': '/builds/slave/test', 10:05:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:05:49 INFO - 'SHELL': '/bin/bash', 10:05:49 INFO - 'SHLVL': '1', 10:05:49 INFO - 'TERM': 'linux', 10:05:49 INFO - 'TMOUT': '86400', 10:05:49 INFO - 'USER': 'cltbld', 10:05:49 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360', 10:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:49 INFO - '_': '/tools/buildbot/bin/python'} 10:05:49 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/QjP6aVfAQqeZ8IyA8y7yDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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:05:49 INFO - mozversion application_buildid: 20160804092622 10:05:49 INFO - mozversion application_changeset: 5ad07719e3bdf424673e7f1c7d0e0dc9b6880cae 10:05:49 INFO - mozversion application_display_name: Nightly 10:05:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:05:49 INFO - mozversion application_name: Firefox 10:05:49 INFO - mozversion application_remotingname: firefox 10:05:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:05:49 INFO - mozversion application_vendor: Mozilla 10:05:49 INFO - mozversion application_version: 51.0a1 10:05:49 INFO - mozversion platform_buildid: 20160804092622 10:05:49 INFO - mozversion platform_changeset: 5ad07719e3bdf424673e7f1c7d0e0dc9b6880cae 10:05:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:05:49 INFO - mozversion platform_version: 51.0a1 10:05:49 INFO - using testdate: 1470330349 10:05:49 INFO - actual date: 1470330349 10:05:49 INFO - starting webserver on 'localhost:59515' 10:05:49 INFO - SUITE-START | Running 2 tests 10:05:49 INFO - TEST-START | dromaeo_css 10:05:49 INFO - operating with platform_type : linux_ 10:05:49 INFO - Initialising browser for dromaeo_css test... 10:05:49 INFO - TEST-INFO | started process 3153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6l1FA6/profile http://localhost:59515/getInfo.html) 10:05:53 INFO - PROCESS | 3153 | __metrics Screen width/height:1600/1200 10:05:53 INFO - PROCESS | 3153 | colorDepth:24 10:05:53 INFO - PROCESS | 3153 | Browser inner width/height: 1024/697 10:05:53 INFO - PROCESS | 3153 | __metrics 10:05:54 INFO - PROCESS | 3153 | 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:05:54 INFO - PROCESS | 3153 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:05:55 INFO - TEST-INFO | 3153: exit 0 10:05:55 INFO - Browser initialized. 10:05:55 INFO - Running cycle 1/1 for dromaeo_css test... 10:05:55 INFO - TEST-INFO | started process 3237 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6l1FA6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:06:07 INFO - PROCESS | 3237 | RSS: Main: 156078080 10:06:07 INFO - PROCESS | 3237 | 10:06:58 INFO - PROCESS | 3237 | 1470330418144 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:09:11 INFO - PROCESS | 3237 | Cycle 1(1): loaded http://localhost:59515/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59515/tests/dromaeo/cssquery-ext.html) 10:09:12 INFO - PROCESS | 3237 | RSS: Main: 244531200 10:09:12 INFO - PROCESS | 3237 | 10:12:14 INFO - PROCESS | 3237 | Cycle 1(1): loaded http://localhost:59515/tests/dromaeo/cssquery-ext.html (next: http://localhost:59515/tests/dromaeo/cssquery-jquery.html) 10:12:15 INFO - PROCESS | 3237 | RSS: Main: 242634752 10:12:15 INFO - PROCESS | 3237 | 10:15:17 INFO - PROCESS | 3237 | Cycle 1(1): loaded http://localhost:59515/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59515/tests/dromaeo/cssquery-mootools.html) 10:15:18 INFO - PROCESS | 3237 | RSS: Main: 185778176 10:15:18 INFO - PROCESS | 3237 | 10:18:20 INFO - PROCESS | 3237 | Cycle 1(1): loaded http://localhost:59515/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59515/tests/dromaeo/cssquery-prototype.html) 10:18:21 INFO - PROCESS | 3237 | RSS: Main: 186589184 10:18:21 INFO - PROCESS | 3237 | 10:21:24 INFO - PROCESS | 3237 | Cycle 1(1): loaded http://localhost:59515/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59515/tests/dromaeo/cssquery-yui.html) 10:21:25 INFO - PROCESS | 3237 | RSS: Main: 189247488 10:21:25 INFO - PROCESS | 3237 | 10:24:28 INFO - PROCESS | 3237 | Cycle 1(1): loaded http://localhost:59515/tests/dromaeo/cssquery-yui.html (next: http://localhost:59515/tests/dromaeo/cssquery-dojo.html) 10:24:28 INFO - PROCESS | 3237 | RSS: Main: 279687168 10:24:28 INFO - PROCESS | 3237 | 10:24:28 INFO - PROCESS | 3237 | __start_tp_report 10:24:28 INFO - PROCESS | 3237 | _x_x_mozilla_page_load 10:24:28 INFO - PROCESS | 3237 | _x_x_mozilla_page_load_details 10:24:28 INFO - PROCESS | 3237 | |i|pagename|runs| 10:24:28 INFO - PROCESS | 3237 | |0;dojo.html;2610.034287313694;2615.8692065396726;2642.062067965872;2655.3759866431396;2657.016903745613;4651.325557794126;4683.063387322536;4700.482946875845;4710.034442939198;4722.102800467908;4777.187878060729;4778.259369797678;4816.855494335166;4833.540813622709;4839.612830973522;4340.67444941629;4376.234159022159;4414.205443020255;4471.441069866267;4558.088382323532;4465.620422264112;4504;4516.435445569304;4526.117407105616;4541.409616749835;4321.762303073329;4334.739915605074;4357.498887627931;4378.9562104378865;4396.1427521633295;4338.110687309094;4343.869683909487;4350.369196466526;4389.846355377546;4414;4374.256376416017;4380.496242932072;4395.604395604379;4422.756748378838;4425.446819147606;4611.515790841981;4712.929306060412;4768.046390721869;4808.63935204861;4866.4403593586485;5128.153854613985;5132.486751324875;5158.3552055993005;5160.92258616121;5176.7929282828645;5108.923366149511;5144.305518754995;5182.481751824825;5195.2986346843445;5208.453112423217;4677.742724150205;4779.378680771478;4814.927776083362;4818.229083346648;4841.491643377465;5302.867428314323;5340.946590534123;5341.225522299244;5361.892762144813;5394.136938089887;5089.236614507853;5109.20807274873;5161.3032240647035;5164.9741751291;5171.922421163686;4975.303457515951;5086.516780905808;5121.2574176744165;5139.871503212375;5215.322008138994;5113.309703190096;5125.103106956268;5166.43169251382;5171.4828517148735;5174.922376164361;5105.463926287686;5116.820911268088;5125.769340379692;5127.87180320495;5173.586113110942;4274.422952901381;4312.029793296483;4447.043885564619;4455.754933478625;4502.369668246448;3799.7340186187253;3846.288436639175;3848.0187552174575;3898.590647981978;3951.2887680217264;4408.845690400821;4409.074094440203;4410.492793328808;4446.9777651111535;4455.465344158657;5019.222020586815;5127.005380866809;5130.333056702605;5190.8961820764125;5232;4330.17726631939;4365.934510982338;4389.034412429261;4411.625011873963;4441.111777644484;4691.62467002639;4693.81224751013;4700.153972284953;4730.763461826895;4743.762811859393;4853.514648535118;4854.417469903634;4858.259388546651;4858.44127925286;4922.655414120977;4995.375578052744;5043.621728370314;5079.72061536619;5109.080365534091;5186.533212010937;4799.256115302133;4799.544043315879;4805.063012712488;4840.7337596432535;4842;5022.799088036584;5023.246513023076;5026.773795179299;5027.723475208899;5033.647644664985;4952.257161425815;5042.193249080129;5067.163917953497;5111.718855462986;5137.306463627362;4990.0269447457395;4994.775235114356;4995.8001679932395;4997.700137991732;5009.198528235464;5021.6735912165595;5024.045431368028;5024.4975502450925;5025.170846810235;5067.341245638044;4796.088743138793;4905.264210368473;4970.502949705001;4970.925436118533;4998.375203099613;5015.1223535880345;5016.172331565251;5017.24741288795;5026.899462010812;5041.521055499722;4914.434839993446;4923.827666031815;4923.950760492349;4924.803007879645;4967.155583550877 10:24:28 INFO - PROCESS | 3237 | |1;ext.html;544.3032917865132;551.553241874082;566.7562947932388;570.0736303506801;616.4636766013566;26810;38752.41871371928;39871.60128398719;40030.59969400305;43741.34387984183;40070.39894401586;40530;40539.18921621566;40551.59448405515;40561.18877622446;7602.809929751773;7759.1852855450215;7761.7671469855995;7767.650455729506;7769.067711874554;7407.000054992588;9713.514324283757;9906.257030722689;9961.75095622608;10330.225233107509;10043.14633256174;10130.59477620898;10136.949315253414;10140.645077422292;10146.695599132037;7428.517146385468;9870.161036311922;9870.703878883645;9944.651937182236;9950.55222514985;9611.615535378576;10007.449590272532;10014.54934527948;10159.59361625534;10213.540390682363;38528.42207366864;38888.22223555513;38898;38934.80532597347;38990.80504597459;2845.587389828484;2853.8145020573597;2857.2142660768454;3199.40810949975;3215.26049008727;29018.41963160746;29220.561691574643;29321.266968325748;29414;29811;3528.2237907660274;3575.964240357589;3579.910502237439;3613.5495709963743;3659.0669379308374;260580;260712;261295;261439;262334.9999999981;53252.467475325524;53669;53670.46329536655;53692;53709;32146;33061.66938330634;33108;35165.64834351624;55585.722071389384;14120.50578229757;14171.291435428393;14172.787408188886;14173;14175.645608859655;10612.893871061346;11246.66260012201;11306.378149201708;11314.773704525864;11315.377654229096;17731.37940172088;18004;18143.546411339823;18291.81708182928;18509.814901851078;6671.966640166768;6792.388685018372;6834.521583489108;6840.418564421981;6846.623435710984;757.2994979643918;924.8150369926042;949.6059135458707;981.1186531108273;994.3089552760762;28056.8597157017;28647.713522864506;29606.851965740465;30006.24984375408;32148.875012389915;936.5691781780457;944.6457578408097;945.5603144537823;987.8221920054316;1032.4270030133198;14914.403423863141;15010.774838377432;15083.245837708071;15121.16833574142;15240.390384384722;423140;426198;427483;427680;427700;35197;49077.754611226715;49547;49748.50251497511;49800.50199498031;1084.1326938449367;1134.5178299222798;1173.6009756682597;1175.9647210583696;1178.293024185482;26769.330766730207;29966.550501742928;30547.54178687277;30608.540871886493;31215.531767023967;44117.33823992578;45001.64995050154;45017;45039.72122648474;45066;367064;372524;372962;373233;373799;41107;42556.78721606496;42580.36129457998;42603.14793704171;43182.784086079366;41761.79119104385;42103.36844947267;42533.78733106315;43170.13659726851;43190.78404607957;36098.45852312165;36319.092022699646;36468;36665.26669466649;37007;36372.454413183295;37064.81467592645;37382;38180;39887.40168897411;36016.459753104245;36193.45709814408;36640;36653.63346366609;37154;32093.1976700575;33829.32341353208;34264;34546;34555.48166777551;25633.35916602025;25683.87158064198;25716.485670286864;26037.73962260353;26359.34101647474 10:24:28 INFO - PROCESS | 3237 | |2;jquery.html;332.49626815374694;346.25209547377654;357.96599323064316;360.6825993126049;372.89186136020555;12445.626631201067;12613.873861261385;13607.931960340196;16577.088260145687;16658.916705416457;16032.679346413064;16122.193890305467;16140.83859161408;16154.030758154518;16767.580810479743;4890.14422476067;4903.215485522317;5037.596992240612;5068.315777370063;5078.542931136197;3689.8524059037604;4997.700137991714;5074.086664400406;5079.796808127689;5460.672359658413;5734.053881109612;5773.826785196451;5797.971010144944;5826.650400975934;5827.446392592718;5260.342457192851;5520.613557051008;5567.858588989247;5790.305163380422;5813.09896965971;5391.676499410009;5394.1908713692865;5403.13549832025;5403.891922161574;5405.486478784509;19961.700574491395;19977.001149942444;20196.596068078703;20609.89695051515;20784;1661.8172001079872;1861.190382183741;1865.5895702945331;2038.5617092325222;2311.306608017588;9206.217471514929;9227.26181905446;9522.52387380635;9602.08780165883;10372.688819335432;1717.4847545736354;1779.1015537153655;1781.2429717370067;1785.2858856457392;1785.7678501794815;68767.9999999995;68996.3100368995;70246.29753702448;70908.64545677291;71036.64481677559;9267.76830579241;9508.47703376307;9540.666076687421;9697.6605818796;10199.28604997658;13209.933950330187;13217.074804763766;13219.801702974462;13220.33898305081;13237.205767653972;6461.289258181596;6844.863102737917;6880.965595172092;6943.930560694429;6959.512834101665;6589.505787065989;6679.79960601173;6800.829979250559;6806.55757375769;6857.417119544894;3984.7210695251633;4095.5494895561465;4174.45732054837;4202.243596152722;4211.620954114144;1634.7384418493223;1697.7113890638375;1714.76850625164;1714.9571260718333;1731.212298404223;852.8507511185642;857.6012154348133;863.404251066762;878.1131057631837;891.0287786312821;16267.18664066792;16511.669766604842;16610.6677866442;16726.16369181536;17241.91379043097;806.2381049907898;809.2069771623842;841.4320333774677;848.6053984897053;873.6636394987976;8939.597718102701;9387.389819661837;9402.576884040234;9485.624584435218;9512.714618561455;310109;407044;424090;426513;431671;50269.24596131061;56872.71563642238;80485.59757201177;83314;85100.57449712836;870.3124531619949;901.5582364641278;921.2952091649893;923.533615524156;925.8472352061834;15374.615634608777;15598.376064957729;16102.355905764107;16237.431689890796;16253.187340633158;37324.6267537332;38224.426633599964;38968;39058.41412378873;39389.409158862065;53412.46587534075;54400;54699.72650136883;55235.723821380634;56901;6930.168379794457;7058.435325173871;7140.750073747394;7581.786914093718;7795.883061754192;8291.709790157316;11529.866974609724;11539.8269025963;11582.71043223926;11686.298822070703;9542.618295268112;9890.456024918698;10231.693049208536;10357.84463233037;10512.475691024605;10122.342047766871;10184.439855808001;10244.385336879812;10251.897481025095;10251.897481025095;9313;9947.502624868872;10019;10090.445025523666;10850.620228291971;7118.074650295428;7122.786316410516;7321.487495875238;7326.780196593898;7590.39276857839;9717.514124293899;9837.360571562825;10090.133325334837;10299.794004120025;10463 10:24:28 INFO - PROCESS | 3237 | |3;mootools.html;1113.0316624536654;1329.5811819276928;1377.063596754207;1411.3014058041272;1645.3665338844548;6132.202813634227;6813.148356455443;7043.964780176092;7069.434445244381;7278.963605181967;7091.8227044323785;7120.537165084266;7131.179914309856;7178.174509931359;7192.100987376578;2113.92601258956;2118.03629348646;2127.4894025433864;2143.9464013399634;2146.5277638919492;2061.876287422752;2110.103206137393;2124.0123342645666;2124.1715730864976;2124.3945475539476;2072.367927782026;2095.4551816527737;2099;2102.190656597206;2135.679648052789;2033.5729496805689;2039.8368130549668;2040.25530681301;2041.3773798991301;2043.4789128772218;2035.8982050897396;2049.600327936053;2083.7916208379193;2086.1655337864822;2086.7704552499213;7076.787696369066;7181.102362204724;7186.748463803794;7246.420286377077;7262.164851042145;4188.539260681353;4371.431713877176;4374;4377.715448495837;4377.802998865059;2665.2137619402324;2832.61759662445;2882.783791215646;2887.7834162437903;2888.9310954946595;918.6968300460832;920.2867777472445;923.4505469245855;925.1581061234244;942.7124726958275;9577.856332155023;9614.086661767122;9625.085616866456;9655.986121457216;9682.854757178648;3595.442706380515;3628.9455658165148;3731.2910546995986;3819.1788765415567;3819.236152769457;7797.259260370256;7798.727044553527;7802.765917022499;7804.141544430108;7809.804754881174;4183.5398106208295;4197.412362269285;4205.768682722419;4206.768627725504;4207.537170911197;3444.9311013779584;3669.5046168766876;3837.0982819037504;3922.843086276517;3927.7446965947124;3124.0940127363265;3183.060997005889;3254.1701866024014;3258.4623537116586;3266.9346613067605;986.3687240166299;997.5062344139698;998.4907697074544;999.3504222255447;1003.5634498992962;736.8121129112042;745.4483682075225;751.8609057324303;755.3805879179021;796.5897562755185;4826.806927722922;4865.367502224688;4924.696854023951;4954.3063971044085;5065.316182315414;362.42374624347417;370.0655843993937;371.30009931279733;393.8975866274789;396.4251834839494;3482.930341393158;3602.423612222032;3604.7656902301264;3617.1138071172204;3712.6658600726064;8959.686410975584;9008.774780630405;9106.453612783254;9106.544672766335;9114.13415725505;8957.552122393854;9074.818503629891;9090.954545227232;9097.545122743968;9111.362204645744;6839.658017099126;6973.267806880306;7032;7032.437405007587;7032.8945065824055;4914.459409465027;4985.476524964826;5073.492650735045;5110.488951105009;5207.76565054581;7865.803354916173;8228.094909560063;8311.293540049164;8421.15788421153;8425.073241943504;8216.712415065444;8357.916420835956;8416.032156301859;8537.359698022548;8568.785780355542;5675.914861277167;6408.807735767934;6503.057056726653;6504.894167991358;6515.511336649675;6585.80242592723;6868.175818901764;6943.51395402317;7014.0531028310525;7014.193367762773;6039.577229593886;6312.116303717391;6342.746290148342;6356.936430635635;6479.449246814073;6145;6147.784827531015;6197.535184861244;6238.563300568917;6271.090691849565;5804.709764511842;5898.941010590011;5906.202662640489;5911.054231322968;5925.348211696623;4313;4378.387025816452;4473.261911784519;4492.326151077234;4503.684742068024;4124.649404800625;4247.87256382309;4248.468941382327;4253.744775313491;4547.795349209359 10:24:28 INFO - PROCESS | 3237 | |4;prototype.html;290.33658091261464;292.4385180453529;295.9570862224976;297.27168437328544;300.52667049397206;4657.7903994320295;4814.398200224968;4840.201366774482;4842.2252439609665;4878;4802.543758342952;4806.471288158308;4826.662133650637;4829.396325459317;4832.855014349567;3584.5661735305957;3707.0361705956375;3713.275911197304;3770.491803278697;3786.6213378662187;3398.966010339902;3675.7610755300952;3722.590515043343;3735.757175783579;3739.551253849542;3728.347539180646;3737.7196710246703;3743.9251214975684;3757.3424650686156;3757.361248587733;3739.4951681522916;3741.345264578715;3750.3436898542645;3770.924581508382;3776.924461510782;3065.3869226154634;3149.165471150147;3248.7492315458717;3285.342931413727;3309.2057906102605;4647.837325693618;4675.223415102239;4678.672492925497;4682.180618391768;4697.03710739301;4253.638440732541;4272.957270427287;4275.871723848259;4287.849925252601;4290.163418133465;4844.224924012176;4951.9752401237765;5045.747712614391;5050.292958985745;5058.7976480940715;3488.8081155536433;3531.5938667053106;3535.4520049392386;3539.592946811098;3547.18414764603;4946.307516947594;5044.924326135074;5227.372715274191;5253.737313134367;5262.973685131588;3616.4756110364374;3621.1128273573145;3636.5454318210222;3642.6721595056574;3658.9451158232646;3704.2591481703766;3712.6101759314884;3713.665770080706;3717.7211709121384;3717.7955212463576;4240.766757828349;4246.660267178619;4259.5101563319995;4264.339027450688;4268.935965960513;4792.209285467929;5029.748512574357;5070.949290507047;5081.59347252219;5121.513456221653;1319.4722111155615;1324.8012798080365;1327.3827670133242;1339.2767905331011;1341.8993575481877;829.5727700234385;858.2490320969152;867.1675191815928;879.2614204068614;884.6505630276005;3993.880183594497;4024.2353952748886;4027.234825383168;4029.194161167778;4029.476168098187;4553.2942393929;4574.467553369592;4597.517260687647;4611.884702882455;4612.884677883079;3957.762534247954;3962.5641179470235;3972.741771784825;3980.3233450313514;3993.301172294895;2453.582890908514;2571.3314538219824;2763.673436750371;2773.4175823076976;2785.2758282846607;4917.409910810726;4918.8770280743265;4921.212605983025;4925.187344088257;4938.506149385104;5340.332458442695;5358.54452371545;5381.48875856793;5384.5692344612335;5388.245645609618;4661.86014419568;4909;4927.187014142626;4929.580985616263;4930.630202734737;5153.665011774223;5195.402528709247;5215.565719427188;5226.817061402832;5257.37021523329;4909.582685471632;5178.818741344035;5182;5196.285225875527;5215.843524694265;4658.347831303688;4796.776821910391;4912.312276281395;4928.507149285043;4950.801967921243;3622.3660859350034;3669.3578623741273;3672;3686.5391826021746;3687.870924517629;5243.5542978847225;5248.002879452892;5260.342457192851;5261.526772503705;5262.868428289324;4940.555350018516;5074.720890351066;5126.512981266774;5133.79464821403;5138.3833939927445;5003.974980125076;5008.499150084962;5022.472640372708;5028.572571331478;5034.16936205522;4981.530448517624;4988.775505102207;4992.051510213048;5034.521720436553;5040.294358789845;4977.253411988231;5022.673526220784;5119.155339368963;5134.691918484903;5137.255098010843;4952.257161425815;4954.380702412199;4967.304577359245;4969.776360063734;4969.900601988013 10:24:28 INFO - PROCESS | 3237 | |5;yui.html;584.8473173093072;600.9038553831385;631.5673763472022;677.6340775980971;696.6760456387779;12651.557195498137;13347.733045339088;14406;14434.566962991114;14497.927510362446;13836;14300.570982870504;14411.711765764678;14413.63965900853;14422.711545769078;774.3882332956957;802.229859335039;806.209914284002;806.6168569929296;806.6612022950375;641.8010416770793;765.0971853213206;793.8412317536487;797.099277816067;800.4756884240832;835.5655059369125;837.417994493827;838.4927119092953;838.6813011055821;839.6053854688287;832.0930186097153;832.4838600067997;832.820943497151;832.8667413213857;833.2375876073386;491.87457198414535;500.3595397890706;500.4970005144842;502.6506577928341;585.0960266388397;12753.489860405572;13149.211047337094;13185;13214.471421143142;13254.271015094166;12015.759684806342;12409.62771116868;12603.621891343275;12666.366681665972;13322.400491977884;9257.305702072304;9531.332806703533;9563.139317461462;9593.568289426992;12034.939825300906;3259.2503724143344;3333.4333163362285;3363.932721345584;3371;3391.5082313064713;47311.76344118257;47494;47948;51803.48196518024;62309.68845155745;10046.799064018825;10318.535665895053;10400.739981500372;10403.53184106717;10426.37441753482;18813.90593047026;19179.232830686895;19190.424287271406;19194.52013699641;19207;6839.692213850389;6849.315068493111;6922.238553759083;7054.576725396492;7201;3673.9081522961606;3692.8522859085874;3723.3298006358573;3758.5489741231227;3893.5911729268587;2977.2408035951125;3094.1491089949996;3095.3654500827274;3247.8700851966128;3250.967490325114;560.5431573267774;565.3272605599406;568.7867049856304;569.9088145896636;576.8702042040592;499.93264380547794;539.3527766679921;549.8684988987677;570.1020892094884;583.3379114704841;7508.136564295067;7665.3101220890385;8102.554359510284;8172.6730930762105;8243.05204901432;491.3072567679555;530.3715097609345;561.9213310136585;566.4081035318103;575.7725698349128;3542.1498840278664;3705.629437056327;3714.5728241252064;3737.7009839213342;3912.628300311466;99008.50495747475;105811.4709426448;108640;111249.44375278072;111402;89697.55151224333;98848.50575747219;99976;100786.49606752065;101272.49363753281;63217.68391158015;63373.68313158497;64971.35028649653;73633.89549156767;81775.591122044;7328.78013659591;8244.175582441947;8326.70856520019;8412.116727743498;8480.194381533744;31614.525782113746;40510.797446012584;43098.353524697784;43467.34798977955;43906.12187756163;39723.40414893721;47377.28934065923;54153.45846541484;64311.678441609365;64448.355516446114;11329.206955513364;11442.427878606202;11553.768924621629;11724.648260552198;11898.881011190124;12136.817947730615;12279.324637145042;12419.813702794647;12624.87375126237;13080.345982701017;11469.254498457574;11901.761964760482;11917;12013.339266340436;12527.749445010866;11014.50434730423;11136.554537818396;11393.943030284796;11599.76800464003;11699.532018719496;10799.190060745319;10960;10979.28634638746;10998.890011100106;11465.082793376343;9500.510087853923;10154.00691662745;10451.320664156805;10586.258961872903;10902.236843421202;9701.223902087957;9724.416535007922;9846.803063938825;9902.335709219205;9904.603815847286 10:24:28 INFO - PROCESS | 3237 | __end_tp_report 10:24:28 INFO - PROCESS | 3237 | __start_cc_report 10:24:28 INFO - PROCESS | 3237 | _x_x_mozilla_cycle_collect,1042 10:24:28 INFO - PROCESS | 3237 | __end_cc_report 10:24:28 INFO - PROCESS | 3237 | __startTimestamp1470331468297__endTimestamp 10:24:28 INFO - PROCESS | 3237 | 10:24:28 INFO - PROCESS | 3237 | ------- Summary: start ------- 10:24:28 INFO - PROCESS | 3237 | Number of tests: 6 10:24:28 INFO - PROCESS | 3237 | 10:24:28 INFO - PROCESS | 3237 | [#0] dojo.html Cycles:165 Average:4746.80 Median:4858.26 stddev:502.28 (10.3%) stddev-sans-first:475.02 10:24:28 INFO - PROCESS | 3237 | Values: 2610.0 2615.9 2642.1 2655.4 2657.0 4651.3 4683.1 4700.5 4710.0 4722.1 4777.2 4778.3 4816.9 4833.5 4839.6 4340.7 4376.2 4414.2 4471.4 4558.1 4465.6 4504.0 4516.4 4526.1 4541.4 4321.8 4334.7 4357.5 4379.0 4396.1 4338.1 4343.9 4350.4 4389.8 4414.0 4374.3 4380.5 4395.6 4422.8 4425.4 4611.5 4712.9 4768.0 4808.6 4866.4 5128.2 5132.5 5158.4 5160.9 5176.8 5108.9 5144.3 5182.5 5195.3 5208.5 4677.7 4779.4 4814.9 4818.2 4841.5 5302.9 5340.9 5341.2 5361.9 5394.1 5089.2 5109.2 5161.3 5165.0 5171.9 4975.3 5086.5 5121.3 5139.9 5215.3 5113.3 5125.1 5166.4 5171.5 5174.9 5105.5 5116.8 5125.8 5127.9 5173.6 4274.4 4312.0 4447.0 4455.8 4502.4 3799.7 3846.3 3848.0 3898.6 3951.3 4408.8 4409.1 4410.5 4447.0 4455.5 5019.2 5127.0 5130.3 5190.9 5232.0 4330.2 4365.9 4389.0 4411.6 4441.1 4691.6 4693.8 4700.2 4730.8 4743.8 4853.5 4854.4 4858.3 4858.4 4922.7 4995.4 5043.6 5079.7 5109.1 5186.5 4799.3 4799.5 4805.1 4840.7 4842.0 5022.8 5023.2 5026.8 5027.7 5033.6 4952.3 5042.2 5067.2 5111.7 5137.3 4990.0 4994.8 4995.8 4997.7 5009.2 5021.7 5024.0 5024.5 5025.2 5067.3 4796.1 4905.3 4970.5 4970.9 4998.4 5015.1 5016.2 5017.2 5026.9 5041.5 4914.4 4923.8 4924.0 4924.8 4967.2 10:24:28 INFO - PROCESS | 3237 | 10:24:28 INFO - PROCESS | 3237 | [#1] ext.html Cycles:180 Average:50731.99 Median:201864.63 stddev:94921.90 (47.0%) stddev-sans-first:95113.39 10:24:28 INFO - PROCESS | 3237 | Values: 544.3 551.6 566.8 570.1 616.5 26810.0 38752.4 39871.6 40030.6 43741.3 40070.4 40530.0 40539.2 40551.6 40561.2 7602.8 7759.2 7761.8 7767.7 7769.1 7407.0 9713.5 9906.3 9961.8 10330.2 10043.1 10130.6 10136.9 10140.6 10146.7 7428.5 9870.2 9870.7 9944.7 9950.6 9611.6 10007.4 10014.5 10159.6 10213.5 38528.4 38888.2 38898.0 38934.8 38990.8 2845.6 2853.8 2857.2 3199.4 3215.3 29018.4 29220.6 29321.3 29414.0 29811.0 3528.2 3576.0 3579.9 3613.5 3659.1 260580.0 260712.0 261295.0 261439.0 262335.0 53252.5 53669.0 53670.5 53692.0 53709.0 32146.0 33061.7 33108.0 35165.6 55585.7 14120.5 14171.3 14172.8 14173.0 14175.6 10612.9 11246.7 11306.4 11314.8 11315.4 17731.4 18004.0 18143.5 18291.8 18509.8 6672.0 6792.4 6834.5 6840.4 6846.6 757.3 924.8 949.6 981.1 994.3 28056.9 28647.7 29606.9 30006.2 32148.9 936.6 944.6 945.6 987.8 1032.4 14914.4 15010.8 15083.2 15121.2 15240.4 423140.0 426198.0 427483.0 427680.0 427700.0 35197.0 49077.8 49547.0 49748.5 49800.5 1084.1 1134.5 1173.6 1176.0 1178.3 26769.3 29966.6 30547.5 30608.5 31215.5 44117.3 45001.6 45017.0 45039.7 45066.0 367064.0 372524.0 372962.0 373233.0 373799.0 41107.0 42556.8 42580.4 42603.1 43182.8 41761.8 42103.4 42533.8 43170.1 43190.8 36098.5 36319.1 36468.0 36665.3 37007.0 36372.5 37064.8 37382.0 38180.0 39887.4 36016.5 36193.5 36640.0 36653.6 37154.0 32093.2 33829.3 34264.0 34546.0 34555.5 25633.4 25683.9 25716.5 26037.7 26359.3 10:24:28 INFO - PROCESS | 3237 | 10:24:28 INFO - PROCESS | 3237 | [#2] jquery.html Cycles:180 Average:24405.69 Median:5052.96 stddev:66435.24 (1314.8%) stddev-sans-first:66597.02 10:24:28 INFO - PROCESS | 3237 | Values: 332.5 346.3 358.0 360.7 372.9 12445.6 12613.9 13607.9 16577.1 16658.9 16032.7 16122.2 16140.8 16154.0 16767.6 4890.1 4903.2 5037.6 5068.3 5078.5 3689.9 4997.7 5074.1 5079.8 5460.7 5734.1 5773.8 5798.0 5826.7 5827.4 5260.3 5520.6 5567.9 5790.3 5813.1 5391.7 5394.2 5403.1 5403.9 5405.5 19961.7 19977.0 20196.6 20609.9 20784.0 1661.8 1861.2 1865.6 2038.6 2311.3 9206.2 9227.3 9522.5 9602.1 10372.7 1717.5 1779.1 1781.2 1785.3 1785.8 68768.0 68996.3 70246.3 70908.6 71036.6 9267.8 9508.5 9540.7 9697.7 10199.3 13209.9 13217.1 13219.8 13220.3 13237.2 6461.3 6844.9 6881.0 6943.9 6959.5 6589.5 6679.8 6800.8 6806.6 6857.4 3984.7 4095.5 4174.5 4202.2 4211.6 1634.7 1697.7 1714.8 1715.0 1731.2 852.9 857.6 863.4 878.1 891.0 16267.2 16511.7 16610.7 16726.2 17241.9 806.2 809.2 841.4 848.6 873.7 8939.6 9387.4 9402.6 9485.6 9512.7 310109.0 407044.0 424090.0 426513.0 431671.0 50269.2 56872.7 80485.6 83314.0 85100.6 870.3 901.6 921.3 923.5 925.8 15374.6 15598.4 16102.4 16237.4 16253.2 37324.6 38224.4 38968.0 39058.4 39389.4 53412.5 54400.0 54699.7 55235.7 56901.0 6930.2 7058.4 7140.8 7581.8 7795.9 8291.7 11529.9 11539.8 11582.7 11686.3 9542.6 9890.5 10231.7 10357.8 10512.5 10122.3 10184.4 10244.4 10251.9 10251.9 9313.0 9947.5 10019.0 10090.4 10850.6 7118.1 7122.8 7321.5 7326.8 7590.4 9717.5 9837.4 10090.1 10299.8 10463.0 10:24:28 INFO - PROCESS | 3237 | 10:24:28 INFO - PROCESS | 3237 | [#3] mootools.html Cycles:180 Average:4757.47 Median:5441.84 stddev:2650.12 (48.7%) stddev-sans-first:2643.39 10:24:28 INFO - PROCESS | 3237 | Values: 1113.0 1329.6 1377.1 1411.3 1645.4 6132.2 6813.1 7044.0 7069.4 7279.0 7091.8 7120.5 7131.2 7178.2 7192.1 2113.9 2118.0 2127.5 2143.9 2146.5 2061.9 2110.1 2124.0 2124.2 2124.4 2072.4 2095.5 2099.0 2102.2 2135.7 2033.6 2039.8 2040.3 2041.4 2043.5 2035.9 2049.6 2083.8 2086.2 2086.8 7076.8 7181.1 7186.7 7246.4 7262.2 4188.5 4371.4 4374.0 4377.7 4377.8 2665.2 2832.6 2882.8 2887.8 2888.9 918.7 920.3 923.5 925.2 942.7 9577.9 9614.1 9625.1 9656.0 9682.9 3595.4 3628.9 3731.3 3819.2 3819.2 7797.3 7798.7 7802.8 7804.1 7809.8 4183.5 4197.4 4205.8 4206.8 4207.5 3444.9 3669.5 3837.1 3922.8 3927.7 3124.1 3183.1 3254.2 3258.5 3266.9 986.4 997.5 998.5 999.4 1003.6 736.8 745.4 751.9 755.4 796.6 4826.8 4865.4 4924.7 4954.3 5065.3 362.4 370.1 371.3 393.9 396.4 3482.9 3602.4 3604.8 3617.1 3712.7 8959.7 9008.8 9106.5 9106.5 9114.1 8957.6 9074.8 9091.0 9097.5 9111.4 6839.7 6973.3 7032.0 7032.4 7032.9 4914.5 4985.5 5073.5 5110.5 5207.8 7865.8 8228.1 8311.3 8421.2 8425.1 8216.7 8357.9 8416.0 8537.4 8568.8 5675.9 6408.8 6503.1 6504.9 6515.5 6585.8 6868.2 6943.5 7014.1 7014.2 6039.6 6312.1 6342.7 6356.9 6479.4 6145.0 6147.8 6197.5 6238.6 6271.1 5804.7 5898.9 5906.2 5911.1 5925.3 4313.0 4378.4 4473.3 4492.3 4503.7 4124.6 4247.9 4248.5 4253.7 4547.8 10:24:28 INFO - PROCESS | 3237 | 10:24:28 INFO - PROCESS | 3237 | [#4] prototype.html Cycles:180 Average:4142.39 Median:4680.43 stddev:1214.82 (26.0%) stddev-sans-first:1183.32 10:24:28 INFO - PROCESS | 3237 | Values: 290.3 292.4 296.0 297.3 300.5 4657.8 4814.4 4840.2 4842.2 4878.0 4802.5 4806.5 4826.7 4829.4 4832.9 3584.6 3707.0 3713.3 3770.5 3786.6 3399.0 3675.8 3722.6 3735.8 3739.6 3728.3 3737.7 3743.9 3757.3 3757.4 3739.5 3741.3 3750.3 3770.9 3776.9 3065.4 3149.2 3248.7 3285.3 3309.2 4647.8 4675.2 4678.7 4682.2 4697.0 4253.6 4273.0 4275.9 4287.8 4290.2 4844.2 4952.0 5045.7 5050.3 5058.8 3488.8 3531.6 3535.5 3539.6 3547.2 4946.3 5044.9 5227.4 5253.7 5263.0 3616.5 3621.1 3636.5 3642.7 3658.9 3704.3 3712.6 3713.7 3717.7 3717.8 4240.8 4246.7 4259.5 4264.3 4268.9 4792.2 5029.7 5070.9 5081.6 5121.5 1319.5 1324.8 1327.4 1339.3 1341.9 829.6 858.2 867.2 879.3 884.7 3993.9 4024.2 4027.2 4029.2 4029.5 4553.3 4574.5 4597.5 4611.9 4612.9 3957.8 3962.6 3972.7 3980.3 3993.3 2453.6 2571.3 2763.7 2773.4 2785.3 4917.4 4918.9 4921.2 4925.2 4938.5 5340.3 5358.5 5381.5 5384.6 5388.2 4661.9 4909.0 4927.2 4929.6 4930.6 5153.7 5195.4 5215.6 5226.8 5257.4 4909.6 5178.8 5182.0 5196.3 5215.8 4658.3 4796.8 4912.3 4928.5 4950.8 3622.4 3669.4 3672.0 3686.5 3687.9 5243.6 5248.0 5260.3 5261.5 5262.9 4940.6 5074.7 5126.5 5133.8 5138.4 5004.0 5008.5 5022.5 5028.6 5034.2 4981.5 4988.8 4992.1 5034.5 5040.3 4977.3 5022.7 5119.2 5134.7 5137.3 4952.3 4954.4 4967.3 4969.8 4969.9 10:24:28 INFO - PROCESS | 3237 | 10:24:28 INFO - PROCESS | 3237 | [#5] yui.html Cycles:180 Average:17655.34 Median:43686.73 stddev:26200.01 (60.0%) stddev-sans-first:26242.16 10:24:28 INFO - PROCESS | 3237 | Values: 584.8 600.9 631.6 677.6 696.7 12651.6 13347.7 14406.0 14434.6 14497.9 13836.0 14300.6 14411.7 14413.6 14422.7 774.4 802.2 806.2 806.6 806.7 641.8 765.1 793.8 797.1 800.5 835.6 837.4 838.5 838.7 839.6 832.1 832.5 832.8 832.9 833.2 491.9 500.4 500.5 502.7 585.1 12753.5 13149.2 13185.0 13214.5 13254.3 12015.8 12409.6 12603.6 12666.4 13322.4 9257.3 9531.3 9563.1 9593.6 12034.9 3259.3 3333.4 3363.9 3371.0 3391.5 47311.8 47494.0 47948.0 51803.5 62309.7 10046.8 10318.5 10400.7 10403.5 10426.4 18813.9 19179.2 19190.4 19194.5 19207.0 6839.7 6849.3 6922.2 7054.6 7201.0 3673.9 3692.9 3723.3 3758.5 3893.6 2977.2 3094.1 3095.4 3247.9 3251.0 560.5 565.3 568.8 569.9 576.9 499.9 539.4 549.9 570.1 583.3 7508.1 7665.3 8102.6 8172.7 8243.1 491.3 530.4 561.9 566.4 575.8 3542.1 3705.6 3714.6 3737.7 3912.6 99008.5 105811.5 108640.0 111249.4 111402.0 89697.6 98848.5 99976.0 100786.5 101272.5 63217.7 63373.7 64971.4 73633.9 81775.6 7328.8 8244.2 8326.7 8412.1 8480.2 31614.5 40510.8 43098.4 43467.3 43906.1 39723.4 47377.3 54153.5 64311.7 64448.4 11329.2 11442.4 11553.8 11724.6 11898.9 12136.8 12279.3 12419.8 12624.9 13080.3 11469.3 11901.8 11917.0 12013.3 12527.7 11014.5 11136.6 11393.9 11599.8 11699.5 10799.2 10960.0 10979.3 10998.9 11465.1 9500.5 10154.0 10451.3 10586.3 10902.2 9701.2 9724.4 9846.8 9902.3 9904.6 10:24:28 INFO - PROCESS | 3237 | -------- Summary: end -------- 10:24:28 INFO - PROCESS | 3237 | 10:24:29 INFO - TEST-INFO | 3237: exit 0 10:24:29 INFO - TEST-OK | dromaeo_css | took 1119986ms 10:24:29 INFO - TEST-START | kraken 10:24:29 INFO - operating with platform_type : linux_ 10:24:29 INFO - Initialising browser for kraken test... 10:24:29 INFO - TEST-INFO | started process 3431 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXWU7VU/profile http://localhost:59515/getInfo.html) 10:24:33 INFO - PROCESS | 3431 | __metrics Screen width/height:1600/1200 10:24:33 INFO - PROCESS | 3431 | colorDepth:24 10:24:33 INFO - PROCESS | 3431 | Browser inner width/height: 1024/697 10:24:33 INFO - PROCESS | 3431 | __metrics 10:24:34 INFO - PROCESS | 3431 | 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:24:34 INFO - PROCESS | 3431 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:24:34 INFO - PROCESS | 3431 | console.error: PushService: 10:24:34 INFO - PROCESS | 3431 | stateChangeProcessEnqueue: Error transitioning state 10:24:34 INFO - PROCESS | 3431 | UnknownError 10:24:35 INFO - TEST-INFO | 3431: exit 0 10:24:35 INFO - Browser initialized. 10:24:35 INFO - Running cycle 1/1 for kraken test... 10:24:35 INFO - TEST-INFO | started process 3512 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXWU7VU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:24:47 INFO - PROCESS | 3512 | RSS: Main: 156352512 10:24:47 INFO - PROCESS | 3512 | 10:24:49 INFO - PROCESS | 3512 | Cycle 1(1): loaded http://localhost:59515/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59515/tests/kraken/driver.html?testName=audio-beat-detection) 10:24:50 INFO - PROCESS | 3512 | RSS: Main: 212480000 10:24:50 INFO - PROCESS | 3512 | 10:24:53 INFO - PROCESS | 3512 | Cycle 1(1): loaded http://localhost:59515/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59515/tests/kraken/driver.html?testName=audio-dft) 10:24:54 INFO - PROCESS | 3512 | RSS: Main: 190803968 10:24:54 INFO - PROCESS | 3512 | 10:24:57 INFO - PROCESS | 3512 | Cycle 1(1): loaded http://localhost:59515/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59515/tests/kraken/driver.html?testName=audio-fft) 10:24:58 INFO - PROCESS | 3512 | RSS: Main: 268935168 10:24:58 INFO - PROCESS | 3512 | 10:25:00 INFO - PROCESS | 3512 | Cycle 1(1): loaded http://localhost:59515/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59515/tests/kraken/driver.html?testName=audio-oscillator) 10:25:00 INFO - PROCESS | 3512 | RSS: Main: 179712000 10:25:00 INFO - PROCESS | 3512 | 10:25:03 INFO - PROCESS | 3512 | Cycle 1(1): loaded http://localhost:59515/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59515/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:25:03 INFO - PROCESS | 3512 | RSS: Main: 183975936 10:25:03 INFO - PROCESS | 3512 | 10:25:07 INFO - PROCESS | 3512 | Cycle 1(1): loaded http://localhost:59515/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59515/tests/kraken/driver.html?testName=imaging-darkroom) 10:25:07 INFO - PROCESS | 3512 | RSS: Main: 219705344 10:25:07 INFO - PROCESS | 3512 | 10:25:11 INFO - PROCESS | 3512 | Cycle 1(1): loaded http://localhost:59515/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59515/tests/kraken/driver.html?testName=imaging-desaturate) 10:25:11 INFO - PROCESS | 3512 | RSS: Main: 213245952 10:25:11 INFO - PROCESS | 3512 | 10:25:14 INFO - PROCESS | 3512 | Cycle 1(1): loaded http://localhost:59515/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59515/tests/kraken/driver.html?testName=json-parse-financial) 10:25:15 INFO - PROCESS | 3512 | RSS: Main: 217477120 10:25:15 INFO - PROCESS | 3512 | 10:25:16 INFO - PROCESS | 3512 | Cycle 1(1): loaded http://localhost:59515/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59515/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:25:17 INFO - PROCESS | 3512 | RSS: Main: 182890496 10:25:17 INFO - PROCESS | 3512 | 10:25:19 INFO - PROCESS | 3512 | Cycle 1(1): loaded http://localhost:59515/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59515/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:25:20 INFO - PROCESS | 3512 | RSS: Main: 189050880 10:25:20 INFO - PROCESS | 3512 | 10:25:22 INFO - PROCESS | 3512 | Cycle 1(1): loaded http://localhost:59515/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59515/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:25:23 INFO - PROCESS | 3512 | RSS: Main: 193335296 10:25:23 INFO - PROCESS | 3512 | 10:25:25 INFO - PROCESS | 3512 | Cycle 1(1): loaded http://localhost:59515/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:25:26 INFO - PROCESS | 3512 | RSS: Main: 194150400 10:25:26 INFO - PROCESS | 3512 | 10:25:29 INFO - PROCESS | 3512 | Cycle 1(1): loaded http://localhost:59515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:25:29 INFO - PROCESS | 3512 | RSS: Main: 195260416 10:25:29 INFO - PROCESS | 3512 | 10:25:31 INFO - PROCESS | 3512 | Cycle 1(1): loaded http://localhost:59515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59515/tests/kraken/driver.html?testName=ai-astar) 10:25:31 INFO - PROCESS | 3512 | RSS: Main: 242327552 10:25:31 INFO - PROCESS | 3512 | 10:25:31 INFO - PROCESS | 3512 | __start_tp_report 10:25:31 INFO - PROCESS | 3512 | _x_x_mozilla_page_load 10:25:31 INFO - PROCESS | 3512 | _x_x_mozilla_page_load_details 10:25:31 INFO - PROCESS | 3512 | |i|pagename|runs| 10:25:31 INFO - PROCESS | 3512 | |0;ai-astar;105;115;115;114;114;118;112;114;114;112 10:25:31 INFO - PROCESS | 3512 | |1;audio-beat-detection;149;121;123;182;123;122;156;121;156;120 10:25:31 INFO - PROCESS | 3512 | |2;audio-dft;162;160;162;163;161;162;163;162;161;162 10:25:31 INFO - PROCESS | 3512 | |3;audio-fft;75;77;77;130;77;77;76;75;104;77 10:25:31 INFO - PROCESS | 3512 | |4;audio-oscillator;85;85;120;85;85;86;126;84;85;133 10:25:31 INFO - PROCESS | 3512 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 10:25:31 INFO - PROCESS | 3512 | |6;imaging-darkroom;147;146;147;146;148;147;147;147;147;145 10:25:31 INFO - PROCESS | 3512 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 10:25:31 INFO - PROCESS | 3512 | |8;json-parse-financial;63;63;61;64;62;63;63;62;62;63 10:25:31 INFO - PROCESS | 3512 | |9;json-stringify-tinderbox;64;65;64;65;65;65;65;65;66;66 10:25:31 INFO - PROCESS | 3512 | |10;stanford-crypto-aes;79;80;79;79;81;79;82;82;78;84 10:25:31 INFO - PROCESS | 3512 | |11;stanford-crypto-ccm;129;140;130;132;131;128;128;129;131;131 10:25:31 INFO - PROCESS | 3512 | |12;stanford-crypto-pbkdf2;171;167;169;166;168;166;170;166;171;171 10:25:31 INFO - PROCESS | 3512 | |13;stanford-crypto-sha256-iterative;67;68;67;67;71;68;68;67;66;67 10:25:31 INFO - PROCESS | 3512 | __end_tp_report 10:25:31 INFO - PROCESS | 3512 | __start_cc_report 10:25:31 INFO - PROCESS | 3512 | _x_x_mozilla_cycle_collect,1909 10:25:31 INFO - PROCESS | 3512 | __end_cc_report 10:25:31 INFO - PROCESS | 3512 | __startTimestamp1470331531865__endTimestamp 10:25:31 INFO - PROCESS | 3512 | 10:25:31 INFO - PROCESS | 3512 | ------- Summary: start ------- 10:25:31 INFO - PROCESS | 3512 | Number of tests: 14 10:25:31 INFO - PROCESS | 3512 | 10:25:31 INFO - PROCESS | 3512 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:3.37 (3.0%) stddev-sans-first:1.79 10:25:31 INFO - PROCESS | 3512 | Values: 105.0 115.0 115.0 114.0 114.0 118.0 112.0 114.0 114.0 112.0 10:25:31 INFO - PROCESS | 3512 | 10:25:31 INFO - PROCESS | 3512 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:136.00 stddev:21.88 (16.1%) stddev-sans-first:22.79 10:25:31 INFO - PROCESS | 3512 | Values: 149.0 121.0 123.0 182.0 123.0 122.0 156.0 121.0 156.0 120.0 10:25:31 INFO - PROCESS | 3512 | 10:25:31 INFO - PROCESS | 3512 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 10:25:31 INFO - PROCESS | 3512 | Values: 162.0 160.0 162.0 163.0 161.0 162.0 163.0 162.0 161.0 162.0 10:25:31 INFO - PROCESS | 3512 | 10:25:31 INFO - PROCESS | 3512 | [#3] audio-fft Cycles:10 Average:84.50 Median:77.00 stddev:18.21 (23.6%) stddev-sans-first:18.99 10:25:31 INFO - PROCESS | 3512 | Values: 75.0 77.0 77.0 130.0 77.0 77.0 76.0 75.0 104.0 77.0 10:25:31 INFO - PROCESS | 3512 | 10:25:31 INFO - PROCESS | 3512 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:85.00 stddev:20.21 (23.8%) stddev-sans-first:20.93 10:25:31 INFO - PROCESS | 3512 | Values: 85.0 85.0 120.0 85.0 85.0 86.0 126.0 84.0 85.0 133.0 10:25:31 INFO - PROCESS | 3512 | 10:25:31 INFO - PROCESS | 3512 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:25:31 INFO - PROCESS | 3512 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 10:25:31 INFO - PROCESS | 3512 | 10:25:31 INFO - PROCESS | 3512 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 10:25:31 INFO - PROCESS | 3512 | Values: 147.0 146.0 147.0 146.0 148.0 147.0 147.0 147.0 147.0 145.0 10:25:31 INFO - PROCESS | 3512 | 10:25:31 INFO - PROCESS | 3512 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 10:25:31 INFO - PROCESS | 3512 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 10:25:31 INFO - PROCESS | 3512 | 10:25:31 INFO - PROCESS | 3512 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:63.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 10:25:31 INFO - PROCESS | 3512 | Values: 63.0 63.0 61.0 64.0 62.0 63.0 63.0 62.0 62.0 63.0 10:25:31 INFO - PROCESS | 3512 | 10:25:31 INFO - PROCESS | 3512 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 10:25:31 INFO - PROCESS | 3512 | Values: 64.0 65.0 64.0 65.0 65.0 65.0 65.0 65.0 66.0 66.0 10:25:31 INFO - PROCESS | 3512 | 10:25:31 INFO - PROCESS | 3512 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.50 stddev:1.89 (2.3%) stddev-sans-first:1.94 10:25:31 INFO - PROCESS | 3512 | Values: 79.0 80.0 79.0 79.0 81.0 79.0 82.0 82.0 78.0 84.0 10:25:31 INFO - PROCESS | 3512 | 10:25:31 INFO - PROCESS | 3512 | [#11] stanford-crypto-ccm Cycles:10 Average:130.90 Median:131.00 stddev:3.48 (2.7%) stddev-sans-first:3.62 10:25:31 INFO - PROCESS | 3512 | Values: 129.0 140.0 130.0 132.0 131.0 128.0 128.0 129.0 131.0 131.0 10:25:31 INFO - PROCESS | 3512 | 10:25:31 INFO - PROCESS | 3512 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.50 Median:169.50 stddev:2.17 (1.3%) stddev-sans-first:2.11 10:25:31 INFO - PROCESS | 3512 | Values: 171.0 167.0 169.0 166.0 168.0 166.0 170.0 166.0 171.0 171.0 10:25:31 INFO - PROCESS | 3512 | 10:25:31 INFO - PROCESS | 3512 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:1.35 (2.0%) stddev-sans-first:1.41 10:25:31 INFO - PROCESS | 3512 | Values: 67.0 68.0 67.0 67.0 71.0 68.0 68.0 67.0 66.0 67.0 10:25:31 INFO - PROCESS | 3512 | -------- Summary: end -------- 10:25:31 INFO - PROCESS | 3512 | 10:25:32 INFO - TEST-INFO | 3512: exit 0 10:25:32 INFO - TEST-OK | kraken | took 63768ms 10:25:32 INFO - SUITE-END | took 1183s 10:25:33 INFO - Completed test suite (00:19:43) 10:25:33 INFO - javascript benchmark 10:25:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2610.034287313694, 2615.8692065396726, 2642.062067965872, 2655.3759866431396, 2657.016903745613, 4651.325557794126, 4683.063387322536, 4700.482946875845, 4710.034442939198, 4722.102800467908, 4777.187878060729, 4778.259369797678, 4816.855494335166, 4833.540813622709, 4839.612830973522, 4340.67444941629, 4376.234159022159, 4414.205443020255, 4471.441069866267, 4558.088382323532, 4465.620422264112, 4504.0, 4516.435445569304, 4526.117407105616, 4541.409616749835, 4321.762303073329, 4334.739915605074, 4357.498887627931, 4378.9562104378865, 4396.1427521633295, 4338.110687309094, 4343.869683909487, 4350.369196466526, 4389.846355377546, 4414.0, 4374.256376416017, 4380.496242932072, 4395.604395604379, 4422.756748378838, 4425.446819147606, 4611.515790841981, 4712.929306060412, 4768.046390721869, 4808.63935204861, 4866.4403593586485, 5128.153854613985, 5132.486751324875, 5158.3552055993005, 5160.92258616121, 5176.7929282828645, 5108.923366149511, 5144.305518754995, 5182.481751824825, 5195.2986346843445, 5208.453112423217, 4677.742724150205, 4779.378680771478, 4814.927776083362, 4818.229083346648, 4841.491643377465, 5302.867428314323, 5340.946590534123, 5341.225522299244, 5361.892762144813, 5394.136938089887, 5089.236614507853, 5109.20807274873, 5161.3032240647035, 5164.9741751291, 5171.922421163686, 4975.303457515951, 5086.516780905808, 5121.2574176744165, 5139.871503212375, 5215.322008138994, 5113.309703190096, 5125.103106956268, 5166.43169251382, 5171.4828517148735, 5174.922376164361, 5105.463926287686, 5116.820911268088, 5125.769340379692, 5127.87180320495, 5173.586113110942, 4274.422952901381, 4312.029793296483, 4447.043885564619, 4455.754933478625, 4502.369668246448, 3799.7340186187253, 3846.288436639175, 3848.0187552174575, 3898.590647981978, 3951.2887680217264, 4408.845690400821, 4409.074094440203, 4410.492793328808, 4446.9777651111535, 4455.465344158657, 5019.222020586815, 5127.005380866809, 5130.333056702605, 5190.8961820764125, 5232.0, 4330.17726631939, 4365.934510982338, 4389.034412429261, 4411.625011873963, 4441.111777644484, 4691.62467002639, 4693.81224751013, 4700.153972284953, 4730.763461826895, 4743.762811859393, 4853.514648535118, 4854.417469903634, 4858.259388546651, 4858.44127925286, 4922.655414120977, 4995.375578052744, 5043.621728370314, 5079.72061536619, 5109.080365534091, 5186.533212010937, 4799.256115302133, 4799.544043315879, 4805.063012712488, 4840.7337596432535, 4842.0, 5022.799088036584, 5023.246513023076, 5026.773795179299, 5027.723475208899, 5033.647644664985, 4952.257161425815, 5042.193249080129, 5067.163917953497, 5111.718855462986, 5137.306463627362, 4990.0269447457395, 4994.775235114356, 4995.8001679932395, 4997.700137991732, 5009.198528235464, 5021.6735912165595, 5024.045431368028, 5024.4975502450925, 5025.170846810235, 5067.341245638044, 4796.088743138793, 4905.264210368473, 4970.502949705001, 4970.925436118533, 4998.375203099613, 5015.1223535880345, 5016.172331565251, 5017.24741288795, 5026.899462010812, 5041.521055499722, 4914.434839993446, 4923.827666031815, 4923.950760492349, 4924.803007879645, 4967.155583550877], "value": 4714.135869215485, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.3032917865132, 551.553241874082, 566.7562947932388, 570.0736303506801, 616.4636766013566, 26810.0, 38752.41871371928, 39871.60128398719, 40030.59969400305, 43741.34387984183, 40070.39894401586, 40530.0, 40539.18921621566, 40551.59448405515, 40561.18877622446, 7602.809929751773, 7759.1852855450215, 7761.7671469855995, 7767.650455729506, 7769.067711874554, 7407.000054992588, 9713.514324283757, 9906.257030722689, 9961.75095622608, 10330.225233107509, 10043.14633256174, 10130.59477620898, 10136.949315253414, 10140.645077422292, 10146.695599132037, 7428.517146385468, 9870.161036311922, 9870.703878883645, 9944.651937182236, 9950.55222514985, 9611.615535378576, 10007.449590272532, 10014.54934527948, 10159.59361625534, 10213.540390682363, 38528.42207366864, 38888.22223555513, 38898.0, 38934.80532597347, 38990.80504597459, 2845.587389828484, 2853.8145020573597, 2857.2142660768454, 3199.40810949975, 3215.26049008727, 29018.41963160746, 29220.561691574643, 29321.266968325748, 29414.0, 29811.0, 3528.2237907660274, 3575.964240357589, 3579.910502237439, 3613.5495709963743, 3659.0669379308374, 260580.0, 260712.0, 261295.0, 261439.0, 262334.9999999981, 53252.467475325524, 53669.0, 53670.46329536655, 53692.0, 53709.0, 32146.0, 33061.66938330634, 33108.0, 35165.64834351624, 55585.722071389384, 14120.50578229757, 14171.291435428393, 14172.787408188886, 14173.0, 14175.645608859655, 10612.893871061346, 11246.66260012201, 11306.378149201708, 11314.773704525864, 11315.377654229096, 17731.37940172088, 18004.0, 18143.546411339823, 18291.81708182928, 18509.814901851078, 6671.966640166768, 6792.388685018372, 6834.521583489108, 6840.418564421981, 6846.623435710984, 757.2994979643918, 924.8150369926042, 949.6059135458707, 981.1186531108273, 994.3089552760762, 28056.8597157017, 28647.713522864506, 29606.851965740465, 30006.24984375408, 32148.875012389915, 936.5691781780457, 944.6457578408097, 945.5603144537823, 987.8221920054316, 1032.4270030133198, 14914.403423863141, 15010.774838377432, 15083.245837708071, 15121.16833574142, 15240.390384384722, 423140.0, 426198.0, 427483.0, 427680.0, 427700.0, 35197.0, 49077.754611226715, 49547.0, 49748.50251497511, 49800.50199498031, 1084.1326938449367, 1134.5178299222798, 1173.6009756682597, 1175.9647210583696, 1178.293024185482, 26769.330766730207, 29966.550501742928, 30547.54178687277, 30608.540871886493, 31215.531767023967, 44117.33823992578, 45001.64995050154, 45017.0, 45039.72122648474, 45066.0, 367064.0, 372524.0, 372962.0, 373233.0, 373799.0, 41107.0, 42556.78721606496, 42580.36129457998, 42603.14793704171, 43182.784086079366, 41761.79119104385, 42103.36844947267, 42533.78733106315, 43170.13659726851, 43190.78404607957, 36098.45852312165, 36319.092022699646, 36468.0, 36665.26669466649, 37007.0, 36372.454413183295, 37064.81467592645, 37382.0, 38180.0, 39887.40168897411, 36016.459753104245, 36193.45709814408, 36640.0, 36653.63346366609, 37154.0, 32093.1976700575, 33829.32341353208, 34264.0, 34546.0, 34555.48166777551, 25633.35916602025, 25683.87158064198, 25716.485670286864, 26037.73962260353, 26359.34101647474], "value": 18299.195707089526, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.49626815374694, 346.25209547377654, 357.96599323064316, 360.6825993126049, 372.89186136020555, 12445.626631201067, 12613.873861261385, 13607.931960340196, 16577.088260145687, 16658.916705416457, 16032.679346413064, 16122.193890305467, 16140.83859161408, 16154.030758154518, 16767.580810479743, 4890.14422476067, 4903.215485522317, 5037.596992240612, 5068.315777370063, 5078.542931136197, 3689.8524059037604, 4997.700137991714, 5074.086664400406, 5079.796808127689, 5460.672359658413, 5734.053881109612, 5773.826785196451, 5797.971010144944, 5826.650400975934, 5827.446392592718, 5260.342457192851, 5520.613557051008, 5567.858588989247, 5790.305163380422, 5813.09896965971, 5391.676499410009, 5394.1908713692865, 5403.13549832025, 5403.891922161574, 5405.486478784509, 19961.700574491395, 19977.001149942444, 20196.596068078703, 20609.89695051515, 20784.0, 1661.8172001079872, 1861.190382183741, 1865.5895702945331, 2038.5617092325222, 2311.306608017588, 9206.217471514929, 9227.26181905446, 9522.52387380635, 9602.08780165883, 10372.688819335432, 1717.4847545736354, 1779.1015537153655, 1781.2429717370067, 1785.2858856457392, 1785.7678501794815, 68767.9999999995, 68996.3100368995, 70246.29753702448, 70908.64545677291, 71036.64481677559, 9267.76830579241, 9508.47703376307, 9540.666076687421, 9697.6605818796, 10199.28604997658, 13209.933950330187, 13217.074804763766, 13219.801702974462, 13220.33898305081, 13237.205767653972, 6461.289258181596, 6844.863102737917, 6880.965595172092, 6943.930560694429, 6959.512834101665, 6589.505787065989, 6679.79960601173, 6800.829979250559, 6806.55757375769, 6857.417119544894, 3984.7210695251633, 4095.5494895561465, 4174.45732054837, 4202.243596152722, 4211.620954114144, 1634.7384418493223, 1697.7113890638375, 1714.76850625164, 1714.9571260718333, 1731.212298404223, 852.8507511185642, 857.6012154348133, 863.404251066762, 878.1131057631837, 891.0287786312821, 16267.18664066792, 16511.669766604842, 16610.6677866442, 16726.16369181536, 17241.91379043097, 806.2381049907898, 809.2069771623842, 841.4320333774677, 848.6053984897053, 873.6636394987976, 8939.597718102701, 9387.389819661837, 9402.576884040234, 9485.624584435218, 9512.714618561455, 310109.0, 407044.0, 424090.0, 426513.0, 431671.0, 50269.24596131061, 56872.71563642238, 80485.59757201177, 83314.0, 85100.57449712836, 870.3124531619949, 901.5582364641278, 921.2952091649893, 923.533615524156, 925.8472352061834, 15374.615634608777, 15598.376064957729, 16102.355905764107, 16237.431689890796, 16253.187340633158, 37324.6267537332, 38224.426633599964, 38968.0, 39058.41412378873, 39389.409158862065, 53412.46587534075, 54400.0, 54699.72650136883, 55235.723821380634, 56901.0, 6930.168379794457, 7058.435325173871, 7140.750073747394, 7581.786914093718, 7795.883061754192, 8291.709790157316, 11529.866974609724, 11539.8269025963, 11582.71043223926, 11686.298822070703, 9542.618295268112, 9890.456024918698, 10231.693049208536, 10357.84463233037, 10512.475691024605, 10122.342047766871, 10184.439855808001, 10244.385336879812, 10251.897481025095, 10251.897481025095, 9313.0, 9947.502624868872, 10019.0, 10090.445025523666, 10850.620228291971, 7118.074650295428, 7122.786316410516, 7321.487495875238, 7326.780196593898, 7590.39276857839, 9717.514124293899, 9837.360571562825, 10090.133325334837, 10299.794004120025, 10463.0], "value": 8052.309884531838, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1113.0316624536654, 1329.5811819276928, 1377.063596754207, 1411.3014058041272, 1645.3665338844548, 6132.202813634227, 6813.148356455443, 7043.964780176092, 7069.434445244381, 7278.963605181967, 7091.8227044323785, 7120.537165084266, 7131.179914309856, 7178.174509931359, 7192.100987376578, 2113.92601258956, 2118.03629348646, 2127.4894025433864, 2143.9464013399634, 2146.5277638919492, 2061.876287422752, 2110.103206137393, 2124.0123342645666, 2124.1715730864976, 2124.3945475539476, 2072.367927782026, 2095.4551816527737, 2099.0, 2102.190656597206, 2135.679648052789, 2033.5729496805689, 2039.8368130549668, 2040.25530681301, 2041.3773798991301, 2043.4789128772218, 2035.8982050897396, 2049.600327936053, 2083.7916208379193, 2086.1655337864822, 2086.7704552499213, 7076.787696369066, 7181.102362204724, 7186.748463803794, 7246.420286377077, 7262.164851042145, 4188.539260681353, 4371.431713877176, 4374.0, 4377.715448495837, 4377.802998865059, 2665.2137619402324, 2832.61759662445, 2882.783791215646, 2887.7834162437903, 2888.9310954946595, 918.6968300460832, 920.2867777472445, 923.4505469245855, 925.1581061234244, 942.7124726958275, 9577.856332155023, 9614.086661767122, 9625.085616866456, 9655.986121457216, 9682.854757178648, 3595.442706380515, 3628.9455658165148, 3731.2910546995986, 3819.1788765415567, 3819.236152769457, 7797.259260370256, 7798.727044553527, 7802.765917022499, 7804.141544430108, 7809.804754881174, 4183.5398106208295, 4197.412362269285, 4205.768682722419, 4206.768627725504, 4207.537170911197, 3444.9311013779584, 3669.5046168766876, 3837.0982819037504, 3922.843086276517, 3927.7446965947124, 3124.0940127363265, 3183.060997005889, 3254.1701866024014, 3258.4623537116586, 3266.9346613067605, 986.3687240166299, 997.5062344139698, 998.4907697074544, 999.3504222255447, 1003.5634498992962, 736.8121129112042, 745.4483682075225, 751.8609057324303, 755.3805879179021, 796.5897562755185, 4826.806927722922, 4865.367502224688, 4924.696854023951, 4954.3063971044085, 5065.316182315414, 362.42374624347417, 370.0655843993937, 371.30009931279733, 393.8975866274789, 396.4251834839494, 3482.930341393158, 3602.423612222032, 3604.7656902301264, 3617.1138071172204, 3712.6658600726064, 8959.686410975584, 9008.774780630405, 9106.453612783254, 9106.544672766335, 9114.13415725505, 8957.552122393854, 9074.818503629891, 9090.954545227232, 9097.545122743968, 9111.362204645744, 6839.658017099126, 6973.267806880306, 7032.0, 7032.437405007587, 7032.8945065824055, 4914.459409465027, 4985.476524964826, 5073.492650735045, 5110.488951105009, 5207.76565054581, 7865.803354916173, 8228.094909560063, 8311.293540049164, 8421.15788421153, 8425.073241943504, 8216.712415065444, 8357.916420835956, 8416.032156301859, 8537.359698022548, 8568.785780355542, 5675.914861277167, 6408.807735767934, 6503.057056726653, 6504.894167991358, 6515.511336649675, 6585.80242592723, 6868.175818901764, 6943.51395402317, 7014.0531028310525, 7014.193367762773, 6039.577229593886, 6312.116303717391, 6342.746290148342, 6356.936430635635, 6479.449246814073, 6145.0, 6147.784827531015, 6197.535184861244, 6238.563300568917, 6271.090691849565, 5804.709764511842, 5898.941010590011, 5906.202662640489, 5911.054231322968, 5925.348211696623, 4313.0, 4378.387025816452, 4473.261911784519, 4492.326151077234, 4503.684742068024, 4124.649404800625, 4247.87256382309, 4248.468941382327, 4253.744775313491, 4547.795349209359], "value": 3779.005428651866, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.33658091261464, 292.4385180453529, 295.9570862224976, 297.27168437328544, 300.52667049397206, 4657.7903994320295, 4814.398200224968, 4840.201366774482, 4842.2252439609665, 4878.0, 4802.543758342952, 4806.471288158308, 4826.662133650637, 4829.396325459317, 4832.855014349567, 3584.5661735305957, 3707.0361705956375, 3713.275911197304, 3770.491803278697, 3786.6213378662187, 3398.966010339902, 3675.7610755300952, 3722.590515043343, 3735.757175783579, 3739.551253849542, 3728.347539180646, 3737.7196710246703, 3743.9251214975684, 3757.3424650686156, 3757.361248587733, 3739.4951681522916, 3741.345264578715, 3750.3436898542645, 3770.924581508382, 3776.924461510782, 3065.3869226154634, 3149.165471150147, 3248.7492315458717, 3285.342931413727, 3309.2057906102605, 4647.837325693618, 4675.223415102239, 4678.672492925497, 4682.180618391768, 4697.03710739301, 4253.638440732541, 4272.957270427287, 4275.871723848259, 4287.849925252601, 4290.163418133465, 4844.224924012176, 4951.9752401237765, 5045.747712614391, 5050.292958985745, 5058.7976480940715, 3488.8081155536433, 3531.5938667053106, 3535.4520049392386, 3539.592946811098, 3547.18414764603, 4946.307516947594, 5044.924326135074, 5227.372715274191, 5253.737313134367, 5262.973685131588, 3616.4756110364374, 3621.1128273573145, 3636.5454318210222, 3642.6721595056574, 3658.9451158232646, 3704.2591481703766, 3712.6101759314884, 3713.665770080706, 3717.7211709121384, 3717.7955212463576, 4240.766757828349, 4246.660267178619, 4259.5101563319995, 4264.339027450688, 4268.935965960513, 4792.209285467929, 5029.748512574357, 5070.949290507047, 5081.59347252219, 5121.513456221653, 1319.4722111155615, 1324.8012798080365, 1327.3827670133242, 1339.2767905331011, 1341.8993575481877, 829.5727700234385, 858.2490320969152, 867.1675191815928, 879.2614204068614, 884.6505630276005, 3993.880183594497, 4024.2353952748886, 4027.234825383168, 4029.194161167778, 4029.476168098187, 4553.2942393929, 4574.467553369592, 4597.517260687647, 4611.884702882455, 4612.884677883079, 3957.762534247954, 3962.5641179470235, 3972.741771784825, 3980.3233450313514, 3993.301172294895, 2453.582890908514, 2571.3314538219824, 2763.673436750371, 2773.4175823076976, 2785.2758282846607, 4917.409910810726, 4918.8770280743265, 4921.212605983025, 4925.187344088257, 4938.506149385104, 5340.332458442695, 5358.54452371545, 5381.48875856793, 5384.5692344612335, 5388.245645609618, 4661.86014419568, 4909.0, 4927.187014142626, 4929.580985616263, 4930.630202734737, 5153.665011774223, 5195.402528709247, 5215.565719427188, 5226.817061402832, 5257.37021523329, 4909.582685471632, 5178.818741344035, 5182.0, 5196.285225875527, 5215.843524694265, 4658.347831303688, 4796.776821910391, 4912.312276281395, 4928.507149285043, 4950.801967921243, 3622.3660859350034, 3669.3578623741273, 3672.0, 3686.5391826021746, 3687.870924517629, 5243.5542978847225, 5248.002879452892, 5260.342457192851, 5261.526772503705, 5262.868428289324, 4940.555350018516, 5074.720890351066, 5126.512981266774, 5133.79464821403, 5138.3833939927445, 5003.974980125076, 5008.499150084962, 5022.472640372708, 5028.572571331478, 5034.16936205522, 4981.530448517624, 4988.775505102207, 4992.051510213048, 5034.521720436553, 5040.294358789845, 4977.253411988231, 5022.673526220784, 5119.155339368963, 5134.691918484903, 5137.255098010843, 4952.257161425815, 4954.380702412199, 4967.304577359245, 4969.776360063734, 4969.900601988013], "value": 3760.825374299967, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.8473173093072, 600.9038553831385, 631.5673763472022, 677.6340775980971, 696.6760456387779, 12651.557195498137, 13347.733045339088, 14406.0, 14434.566962991114, 14497.927510362446, 13836.0, 14300.570982870504, 14411.711765764678, 14413.63965900853, 14422.711545769078, 774.3882332956957, 802.229859335039, 806.209914284002, 806.6168569929296, 806.6612022950375, 641.8010416770793, 765.0971853213206, 793.8412317536487, 797.099277816067, 800.4756884240832, 835.5655059369125, 837.417994493827, 838.4927119092953, 838.6813011055821, 839.6053854688287, 832.0930186097153, 832.4838600067997, 832.820943497151, 832.8667413213857, 833.2375876073386, 491.87457198414535, 500.3595397890706, 500.4970005144842, 502.6506577928341, 585.0960266388397, 12753.489860405572, 13149.211047337094, 13185.0, 13214.471421143142, 13254.271015094166, 12015.759684806342, 12409.62771116868, 12603.621891343275, 12666.366681665972, 13322.400491977884, 9257.305702072304, 9531.332806703533, 9563.139317461462, 9593.568289426992, 12034.939825300906, 3259.2503724143344, 3333.4333163362285, 3363.932721345584, 3371.0, 3391.5082313064713, 47311.76344118257, 47494.0, 47948.0, 51803.48196518024, 62309.68845155745, 10046.799064018825, 10318.535665895053, 10400.739981500372, 10403.53184106717, 10426.37441753482, 18813.90593047026, 19179.232830686895, 19190.424287271406, 19194.52013699641, 19207.0, 6839.692213850389, 6849.315068493111, 6922.238553759083, 7054.576725396492, 7201.0, 3673.9081522961606, 3692.8522859085874, 3723.3298006358573, 3758.5489741231227, 3893.5911729268587, 2977.2408035951125, 3094.1491089949996, 3095.3654500827274, 3247.8700851966128, 3250.967490325114, 560.5431573267774, 565.3272605599406, 568.7867049856304, 569.9088145896636, 576.8702042040592, 499.93264380547794, 539.3527766679921, 549.8684988987677, 570.1020892094884, 583.3379114704841, 7508.136564295067, 7665.3101220890385, 8102.554359510284, 8172.6730930762105, 8243.05204901432, 491.3072567679555, 530.3715097609345, 561.9213310136585, 566.4081035318103, 575.7725698349128, 3542.1498840278664, 3705.629437056327, 3714.5728241252064, 3737.7009839213342, 3912.628300311466, 99008.50495747475, 105811.4709426448, 108640.0, 111249.44375278072, 111402.0, 89697.55151224333, 98848.50575747219, 99976.0, 100786.49606752065, 101272.49363753281, 63217.68391158015, 63373.68313158497, 64971.35028649653, 73633.89549156767, 81775.591122044, 7328.78013659591, 8244.175582441947, 8326.70856520019, 8412.116727743498, 8480.194381533744, 31614.525782113746, 40510.797446012584, 43098.353524697784, 43467.34798977955, 43906.12187756163, 39723.40414893721, 47377.28934065923, 54153.45846541484, 64311.678441609365, 64448.355516446114, 11329.206955513364, 11442.427878606202, 11553.768924621629, 11724.648260552198, 11898.881011190124, 12136.817947730615, 12279.324637145042, 12419.813702794647, 12624.87375126237, 13080.345982701017, 11469.254498457574, 11901.761964760482, 11917.0, 12013.339266340436, 12527.749445010866, 11014.50434730423, 11136.554537818396, 11393.943030284796, 11599.76800464003, 11699.532018719496, 10799.190060745319, 10960.0, 10979.28634638746, 10998.890011100106, 11465.082793376343, 9500.510087853923, 10154.00691662745, 10451.320664156805, 10586.258961872903, 10902.236843421202, 9701.223902087957, 9724.416535007922, 9846.803063938825, 9902.335709219205, 9904.603815847286], "value": 6500.837916431708, "unit": "score"}], "name": "dromaeo_css", "value": 6327.613768459457, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 115.0, 114.0, 114.0, 118.0, 112.0, 114.0, 114.0, 112.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 121.0, 123.0, 182.0, 123.0, 122.0, 156.0, 121.0, 156.0, 120.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 163.0, 161.0, 162.0, 163.0, 162.0, 161.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 130.0, 77.0, 77.0, 76.0, 75.0, 104.0, 77.0], "value": 84.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 120.0, 85.0, 85.0, 86.0, 126.0, 84.0, 85.0, 133.0], "value": 97.4, "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, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 145.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 61.0, 64.0, 62.0, 63.0, 63.0, 62.0, 62.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 79.0, 81.0, 79.0, 82.0, 82.0, 78.0, 84.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 140.0, 130.0, 132.0, 131.0, 128.0, 128.0, 129.0, 131.0, 131.0], "value": 130.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 167.0, 169.0, 166.0, 168.0, 166.0, 170.0, 166.0, 171.0, 171.0], "value": 168.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 71.0, 68.0, 68.0, 67.0, 66.0, 67.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1527.9, "alertThreshold": 2.0}]} 10:25:33 INFO - Return code: 0 10:25:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:25:33 INFO - # TBPL SUCCESS # 10:25:33 INFO - Running post-action listener: _resource_record_post_action 10:25:33 INFO - [mozharness: 2016-08-04 17:25:33.182190Z] Finished run-tests step (success) 10:25:33 INFO - Running post-run listener: _resource_record_post_run 10:25:33 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535904256; Read time: 12; Write time: 745784 10:25:33 INFO - TinderboxPrint: CPU usage
13.0% 10:25:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:25:33 INFO - TinderboxPrint: I/O write bytes / time
535,904,256 / 745,784 10:25:33 INFO - TinderboxPrint: CPU idle
8,329.9 (87.0%) 10:25:33 INFO - TinderboxPrint: CPU user
1,201.8 (12.5%) 10:25:33 INFO - TinderboxPrint: Swap in / out
0 / 0 10:25:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 251617280; Read time: 0; Write time: 364736 10:25:33 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 283672576; Read time: 0; Write time: 381048 10:25:33 INFO - Running post-run listener: _upload_blobber_files 10:25:33 INFO - Blob upload gear active. 10:25:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:25:33 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:25:33 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:25:33 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:25:34 INFO - (blobuploader) - INFO - Open directory for files ... 10:25:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:25:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:25:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:38 INFO - (blobuploader) - INFO - Done attempting. 10:25:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:25:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:25:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:39 INFO - (blobuploader) - INFO - Done attempting. 10:25:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:25:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:25:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:40 INFO - (blobuploader) - INFO - Done attempting. 10:25:40 INFO - (blobuploader) - INFO - Iteration through files over. 10:25:40 INFO - Return code: 0 10:25:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:25:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:25:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e0f0a5d46ba11ab40b599b1893ab0b244e1d73d87a4d23c156838d3f8a77819e7836166092ccff0de8998e8149b3c0da93b7550c9557061c2245eda3cffb7525", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b120ed2d5359e547570e2b6714283d80669e7be69c9e188965d2517986eff472263487fbd90217ae499338aac85c63923eeed9d571b49dc34d0ece8410413108", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c423c70f5a65803d945f36c0ec50c4311ec9677515b32719990680159ad0c403e518b212d2f9bc7c2bff81218333be8f7b98025f0db0e3a5d5c28da7826f5b1b"} 10:25:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:25:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:25:40 INFO - Contents: 10:25:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e0f0a5d46ba11ab40b599b1893ab0b244e1d73d87a4d23c156838d3f8a77819e7836166092ccff0de8998e8149b3c0da93b7550c9557061c2245eda3cffb7525", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b120ed2d5359e547570e2b6714283d80669e7be69c9e188965d2517986eff472263487fbd90217ae499338aac85c63923eeed9d571b49dc34d0ece8410413108", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c423c70f5a65803d945f36c0ec50c4311ec9677515b32719990680159ad0c403e518b212d2f9bc7c2bff81218333be8f7b98025f0db0e3a5d5c28da7826f5b1b"} 10:25:40 INFO - Running post-run listener: copy_logs_to_upload_dir 10:25:40 INFO - Copying logs to upload dir... 10:25:40 INFO - mkdir: /builds/slave/test/build/upload/logs 10:25:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.467170 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-04 10:25:39.946306) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 10:25:39.949808) ========= 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=20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360 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/e0f0a5d46ba11ab40b599b1893ab0b244e1d73d87a4d23c156838d3f8a77819e7836166092ccff0de8998e8149b3c0da93b7550c9557061c2245eda3cffb7525", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b120ed2d5359e547570e2b6714283d80669e7be69c9e188965d2517986eff472263487fbd90217ae499338aac85c63923eeed9d571b49dc34d0ece8410413108", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c423c70f5a65803d945f36c0ec50c4311ec9677515b32719990680159ad0c403e518b212d2f9bc7c2bff81218333be8f7b98025f0db0e3a5d5c28da7826f5b1b"} build_url:https://queue.taskcluster.net/v1/task/QjP6aVfAQqeZ8IyA8y7yDA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011431 build_url: 'https://queue.taskcluster.net/v1/task/QjP6aVfAQqeZ8IyA8y7yDA/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/e0f0a5d46ba11ab40b599b1893ab0b244e1d73d87a4d23c156838d3f8a77819e7836166092ccff0de8998e8149b3c0da93b7550c9557061c2245eda3cffb7525", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b120ed2d5359e547570e2b6714283d80669e7be69c9e188965d2517986eff472263487fbd90217ae499338aac85c63923eeed9d571b49dc34d0ece8410413108", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c423c70f5a65803d945f36c0ec50c4311ec9677515b32719990680159ad0c403e518b212d2f9bc7c2bff81218333be8f7b98025f0db0e3a5d5c28da7826f5b1b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 10:25:39.974962) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:25:39.975275) ========= 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=20e666a3d4cfbb71505a330e000001b4-1470330055.247591-1782384360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:25:40.057225) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 10:25:40.057550) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 10:25:40.057869) ========= ========= Total master_lag: 0.17 =========