builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1470331874.48 results: success (0) buildid: 20160804073002 builduid: 75068d66a11a40bd935b2d8a9019af2f revision: d2c3da5ac021138cc92099d2c10b6a591929b6c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:14.481853) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:14.482489) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:14.482843) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:14.498880) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:14.499316) ========= 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=6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 10:31:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 64.9M=0s 2016-08-04 10:31:15 (64.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116722 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:14.647609) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:14.647986) ========= 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=6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020767 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:14.698469) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:14.698870) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d2c3da5ac021138cc92099d2c10b6a591929b6c4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d2c3da5ac021138cc92099d2c10b6a591929b6c4 --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=6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 10:31:15,952 truncating revision to first 12 chars 2016-08-04 10:31:15,952 Setting DEBUG logging. 2016-08-04 10:31:15,952 attempt 1/10 2016-08-04 10:31:15,952 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d2c3da5ac021?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 10:31:16,256 unpacking tar archive at: mozilla-inbound-d2c3da5ac021/testing/mozharness/ program finished with exit code 0 elapsedTime=0.680831 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:15.393667) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:15.394036) ========= script_repo_revision: d2c3da5ac021138cc92099d2c10b6a591929b6c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:15.394507) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:15.394776) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 10:31:15.411158) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-08-04 10:31:15.411546) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:31:16 INFO - MultiFileLogger online at 20160804 10:31:16 in /builds/slave/test 10:31:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 10:31:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:31:16 INFO - {'append_to_log': False, 10:31:16 INFO - 'base_work_dir': '/builds/slave/test', 10:31:16 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:31:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:31:16 INFO - 'branch': 'Mozilla-Inbound', 10:31:16 INFO - 'buildbot_json_path': 'buildprops.json', 10:31:16 INFO - 'config_files': ('talos/linux_config.py',), 10:31:16 INFO - 'default_actions': ('clobber', 10:31:16 INFO - 'read-buildbot-config', 10:31:16 INFO - 'download-and-extract', 10:31:16 INFO - 'populate-webroot', 10:31:16 INFO - 'create-virtualenv', 10:31:16 INFO - 'install', 10:31:16 INFO - 'run-tests'), 10:31:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:31:16 INFO - 'download_minidump_stackwalk': True, 10:31:16 INFO - 'download_symbols': 'ondemand', 10:31:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:31:16 INFO - 'tooltool.py': '/tools/tooltool.py', 10:31:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:31:16 INFO - '/tools/misc-python/virtualenv.py')}, 10:31:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:31:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:31:16 INFO - 'installer_path': 'installer.exe', 10:31:16 INFO - 'log_level': 'info', 10:31:16 INFO - 'log_name': 'talos', 10:31:16 INFO - 'log_to_console': True, 10:31:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:31:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:31:16 INFO - 'opt_config_files': (), 10:31:16 INFO - 'pip_index': False, 10:31:16 INFO - 'sps_profile': False, 10:31:16 INFO - 'sps_profile_interval': 0, 10:31:16 INFO - 'suite': 'dromaeojs-e10s', 10:31:16 INFO - 'system_bits': '32', 10:31:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:31:16 INFO - 'title': 'talos-linux64-ix-050', 10:31:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:31:16 INFO - 'use_talos_json': True, 10:31:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:31:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:31:16 INFO - 'work_dir': 'build'} 10:31:16 INFO - [mozharness: 2016-08-04 17:31:16.758594Z] Running clobber step. 10:31:16 INFO - Running pre-action listener: _resource_record_pre_action 10:31:16 INFO - Running main action method: clobber 10:31:16 INFO - rmtree: /builds/slave/test/build 10:31:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:31:17 INFO - Running post-action listener: _resource_record_post_action 10:31:17 INFO - [mozharness: 2016-08-04 17:31:17.739848Z] Finished clobber step (success) 10:31:17 INFO - [mozharness: 2016-08-04 17:31:17.739949Z] Running read-buildbot-config step. 10:31:17 INFO - Running pre-action listener: _resource_record_pre_action 10:31:17 INFO - Running main action method: read_buildbot_config 10:31:17 INFO - Using buildbot properties: 10:31:17 INFO - { 10:31:17 INFO - "project": "", 10:31:17 INFO - "product": "firefox", 10:31:17 INFO - "script_repo_revision": "production", 10:31:17 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 10:31:17 INFO - "repository": "", 10:31:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 10:31:17 INFO - "buildid": "20160804073002", 10:31:17 INFO - "pgo_build": "True", 10:31:17 INFO - "basedir": "/builds/slave/test", 10:31:17 INFO - "buildnumber": 1122, 10:31:17 INFO - "slavename": "talos-linux64-ix-050", 10:31:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:31:17 INFO - "platform": "ubuntu64_hw", 10:31:17 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:31:17 INFO - "branch": "mozilla-inbound", 10:31:17 INFO - "repo_path": "integration/mozilla-inbound", 10:31:17 INFO - "revision": "d2c3da5ac021138cc92099d2c10b6a591929b6c4", 10:31:17 INFO - "stage_platform": "linux64-pgo", 10:31:17 INFO - "builduid": "75068d66a11a40bd935b2d8a9019af2f", 10:31:17 INFO - "slavebuilddir": "test" 10:31:17 INFO - } 10:31:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:31:17 INFO - Running post-action listener: _resource_record_post_action 10:31:17 INFO - [mozharness: 2016-08-04 17:31:17.742392Z] Finished read-buildbot-config step (success) 10:31:17 INFO - [mozharness: 2016-08-04 17:31:17.742481Z] Running download-and-extract step. 10:31:17 INFO - Running pre-action listener: _resource_record_pre_action 10:31:17 INFO - Running main action method: download_and_extract 10:31:17 INFO - mkdir: /builds/slave/test/build/tests 10:31:17 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:31:17 INFO - trying https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:31:17 INFO - Downloading https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/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:31:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/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:31:18 INFO - Downloaded 1361 bytes. 10:31:18 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:31:18 INFO - Using the following test package requirements: 10:31:18 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:31:18 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:31:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:31:18 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:31:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:31:18 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:31:18 INFO - u'jsshell-linux-x86_64.zip'], 10:31:18 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:31:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:31:18 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:31:18 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:31:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:31:18 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:31:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:31:18 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:31:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:31:18 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:31:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:31:18 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:31: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:31:18 INFO - trying https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:31:18 INFO - Downloading https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/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:31:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/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:31:19 INFO - Downloaded 21823750 bytes. 10:31:19 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:31:19 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:31:20 INFO - Return code: 0 10:31:20 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:31:20 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:31:20 INFO - trying https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:31:20 INFO - Downloading https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/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:31:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/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:31:21 INFO - Downloaded 21823750 bytes. 10:31:21 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:31:21 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:31:22 INFO - Return code: 0 10:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:22 INFO - trying https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:31:22 INFO - Downloading https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/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:31:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/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:31:23 INFO - Downloaded 14413723 bytes. 10:31:23 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:31:23 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:31:23 INFO - Return code: 0 10:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:23 INFO - trying https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:31:23 INFO - Downloading https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/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:31:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/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:31:25 INFO - Downloaded 59363470 bytes. 10:31:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:31:25 INFO - mkdir: /builds/slave/test/properties 10:31:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:31:25 INFO - Writing to file /builds/slave/test/properties/build_url 10:31:25 INFO - Contents: 10:31:25 INFO - build_url:https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:31:25 INFO - Running post-action listener: _resource_record_post_action 10:31:25 INFO - Running post-action listener: set_extra_try_arguments 10:31:25 INFO - [mozharness: 2016-08-04 17:31:25.937907Z] Finished download-and-extract step (success) 10:31:25 INFO - [mozharness: 2016-08-04 17:31:25.938139Z] Running populate-webroot step. 10:31:25 INFO - Running pre-action listener: _resource_record_pre_action 10:31:25 INFO - Running main action method: populate_webroot 10:31:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:31:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:31:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:31:25 INFO - '--tppagecycles', 10:31:25 INFO - '7'], 10:31:25 INFO - 'tests': ['tsvgm']}}, 10:31:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:31:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:31:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:31:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:31:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:31:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:31:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:25 INFO - 'talos_options': ['--disable-e10s'], 10:31:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:31:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:31:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:25 INFO - 'talos_options': ['--disable-e10s'], 10:31:25 INFO - 'tests': ['damp', 'tps']}, 10:31:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:25 INFO - 'tests': ['damp', 'tps']}, 10:31:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:31:25 INFO - 'tests': ['dromaeo_dom']}, 10:31:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:31:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:31:25 INFO - 'tests': ['basic_compositor_video']}, 10:31:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:31:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:31:25 INFO - 'tests': ['a11yr', 10:31:25 INFO - 'ts_paint', 10:31:25 INFO - 'tpaint', 10:31:25 INFO - 'sessionrestore', 10:31:25 INFO - 'sessionrestore_no_auto_restore', 10:31:25 INFO - 'tabpaint']}, 10:31:25 INFO - 'other-e10s': {'tests': ['a11yr', 10:31:25 INFO - 'ts_paint', 10:31:25 INFO - 'tpaint', 10:31:25 INFO - 'sessionrestore', 10:31:25 INFO - 'sessionrestore_no_auto_restore', 10:31:25 INFO - 'tabpaint']}, 10:31:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:31:25 INFO - 'ts_paint', 10:31:25 INFO - 'tpaint', 10:31:25 INFO - 'sessionrestore', 10:31:25 INFO - 'sessionrestore_no_auto_restore', 10:31:25 INFO - 'tabpaint']}, 10:31:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:31:25 INFO - 'ts_paint', 10:31:25 INFO - 'tpaint', 10:31:25 INFO - 'sessionrestore', 10:31:25 INFO - 'sessionrestore_no_auto_restore', 10:31:25 INFO - 'tabpaint']}, 10:31:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:31:25 INFO - 'tests': ['a11yr', 10:31:25 INFO - 'ts_paint', 10:31:25 INFO - 'tpaint', 10:31:25 INFO - 'sessionrestore', 10:31:25 INFO - 'sessionrestore_no_auto_restore', 10:31:25 INFO - 'tabpaint']}, 10:31:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:31:25 INFO - 'tests': ['a11yr', 10:31:25 INFO - 'ts_paint', 10:31:25 INFO - 'tpaint', 10:31:25 INFO - 'sessionrestore', 10:31:25 INFO - 'sessionrestore_no_auto_restore', 10:31:25 INFO - 'tabpaint']}, 10:31:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:31:25 INFO - 'tests': ['tsvgx', 10:31:25 INFO - 'tsvgr_opacity', 10:31:25 INFO - 'tart', 10:31:25 INFO - 'tscrollx', 10:31:25 INFO - 'cart']}, 10:31:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:31:25 INFO - 'tsvgr_opacity', 10:31:25 INFO - 'tart', 10:31:25 INFO - 'tscrollx', 10:31:25 INFO - 'cart']}, 10:31:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:25 INFO - 'talos_options': ['--disable-e10s'], 10:31:25 INFO - 'tests': ['tp5o']}, 10:31:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:25 INFO - 'tests': ['tp5o']}, 10:31:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:25 INFO - 'talos_options': ['--disable-e10s', 10:31:25 INFO - '--xperf_path', 10:31:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:31:25 INFO - 'tests': ['tp5n']}, 10:31:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:25 INFO - 'talos_options': ['--xperf_path', 10:31:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:31:25 INFO - 'tests': ['tp5n']}}, 10:31:25 INFO - 'talos.zip': {'path': '', 10:31:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:31:25 INFO - Running post-action listener: _resource_record_post_action 10:31:25 INFO - [mozharness: 2016-08-04 17:31:25.958578Z] Finished populate-webroot step (success) 10:31:25 INFO - [mozharness: 2016-08-04 17:31:25.958666Z] Running create-virtualenv step. 10:31:25 INFO - Running pre-action listener: _resource_record_pre_action 10:31:25 INFO - Running main action method: create_virtualenv 10:31:25 INFO - Creating virtualenv /builds/slave/test/build/venv 10:31:25 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:31:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:31:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:31:26 INFO - Using real prefix '/usr' 10:31:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:31:26 INFO - Installing distribute.............................................................................................................................................................................................done. 10:31:28 INFO - Installing pip.................done. 10:31:28 INFO - Return code: 0 10:31:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:31: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:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31: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:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:28 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 0x1443030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1701570>, '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 0x1702470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702900>, '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': '6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956', '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:31:28 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:31:28 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:31:28 INFO - Using env: {'DISPLAY': ':0', 10:31:28 INFO - 'HOME': '/home/cltbld', 10:31:28 INFO - 'LANG': 'en_US.UTF-8', 10:31:28 INFO - 'LANGUAGE': 'en_US:en', 10:31:28 INFO - 'LOGNAME': 'cltbld', 10:31:28 INFO - 'MAIL': '/var/mail/cltbld', 10:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:28 INFO - 'MOZ_NO_REMOTE': '1', 10:31:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:28 INFO - 'NO_EM_RESTART': '1', 10:31:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:28 INFO - 'PWD': '/builds/slave/test', 10:31:28 INFO - 'SHELL': '/bin/bash', 10:31:28 INFO - 'SHLVL': '1', 10:31:28 INFO - 'TERM': 'linux', 10:31:28 INFO - 'TMOUT': '86400', 10:31:28 INFO - 'USER': 'cltbld', 10:31:28 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956', 10:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:28 INFO - '_': '/tools/buildbot/bin/python'} 10:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:28 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:31:28 INFO - Cleaning up... 10:31:28 INFO - Return code: 0 10:31:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:31: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:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31: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:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:28 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 0x1443030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1701570>, '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 0x1702470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702900>, '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': '6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956', '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:31:28 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:31:28 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:31:28 INFO - Using env: {'DISPLAY': ':0', 10:31:28 INFO - 'HOME': '/home/cltbld', 10:31:28 INFO - 'LANG': 'en_US.UTF-8', 10:31:28 INFO - 'LANGUAGE': 'en_US:en', 10:31:28 INFO - 'LOGNAME': 'cltbld', 10:31:28 INFO - 'MAIL': '/var/mail/cltbld', 10:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:28 INFO - 'MOZ_NO_REMOTE': '1', 10:31:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:28 INFO - 'NO_EM_RESTART': '1', 10:31:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:28 INFO - 'PWD': '/builds/slave/test', 10:31:28 INFO - 'SHELL': '/bin/bash', 10:31:28 INFO - 'SHLVL': '1', 10:31:28 INFO - 'TERM': 'linux', 10:31:28 INFO - 'TMOUT': '86400', 10:31:28 INFO - 'USER': 'cltbld', 10:31:28 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956', 10:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:28 INFO - '_': '/tools/buildbot/bin/python'} 10:31:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:29 INFO - Downloading/unpacking psutil>=3.1.1 10:31: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:31: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:31: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:31: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:31: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:31: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:31:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:31:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:31:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:31:31 INFO - Installing collected packages: psutil 10:31:31 INFO - Running setup.py install for psutil 10:31:31 INFO - building 'psutil._psutil_linux' extension 10:31:31 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:31:31 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:31:31 INFO - building 'psutil._psutil_posix' extension 10:31:31 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:31:31 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:31:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:31:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:31:31 INFO - Successfully installed psutil 10:31:31 INFO - Cleaning up... 10:31:31 INFO - Return code: 0 10:31:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:31 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 0x1443030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1701570>, '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 0x1702470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702900>, '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': '6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956', '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:31:31 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:31:31 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:31:31 INFO - Using env: {'DISPLAY': ':0', 10:31:31 INFO - 'HOME': '/home/cltbld', 10:31:31 INFO - 'LANG': 'en_US.UTF-8', 10:31:31 INFO - 'LANGUAGE': 'en_US:en', 10:31:31 INFO - 'LOGNAME': 'cltbld', 10:31:31 INFO - 'MAIL': '/var/mail/cltbld', 10:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:31 INFO - 'MOZ_NO_REMOTE': '1', 10:31:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:31 INFO - 'NO_EM_RESTART': '1', 10:31:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:31 INFO - 'PWD': '/builds/slave/test', 10:31:31 INFO - 'SHELL': '/bin/bash', 10:31:31 INFO - 'SHLVL': '1', 10:31:31 INFO - 'TERM': 'linux', 10:31:31 INFO - 'TMOUT': '86400', 10:31:31 INFO - 'USER': 'cltbld', 10:31:31 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956', 10:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:31 INFO - '_': '/tools/buildbot/bin/python'} 10:31:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:31:31 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:31:31 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:31:31 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:31:31 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:31:31 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:31:31 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:31:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:31:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:31:33 INFO - Installing collected packages: mozsystemmonitor 10:31:33 INFO - Running setup.py install for mozsystemmonitor 10:31:33 INFO - Successfully installed mozsystemmonitor 10:31:33 INFO - Cleaning up... 10:31:33 INFO - Return code: 0 10:31:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:31:33 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:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:33 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:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:33 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 0x1443030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1701570>, '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 0x1702470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702900>, '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': '6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956', '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:31:33 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:31:33 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:31:33 INFO - Using env: {'DISPLAY': ':0', 10:31:33 INFO - 'HOME': '/home/cltbld', 10:31:33 INFO - 'LANG': 'en_US.UTF-8', 10:31:33 INFO - 'LANGUAGE': 'en_US:en', 10:31:33 INFO - 'LOGNAME': 'cltbld', 10:31:33 INFO - 'MAIL': '/var/mail/cltbld', 10:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:33 INFO - 'MOZ_NO_REMOTE': '1', 10:31:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:33 INFO - 'NO_EM_RESTART': '1', 10:31:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:33 INFO - 'PWD': '/builds/slave/test', 10:31:33 INFO - 'SHELL': '/bin/bash', 10:31:33 INFO - 'SHLVL': '1', 10:31:33 INFO - 'TERM': 'linux', 10:31:33 INFO - 'TMOUT': '86400', 10:31:33 INFO - 'USER': 'cltbld', 10:31:33 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956', 10:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:33 INFO - '_': '/tools/buildbot/bin/python'} 10:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:34 INFO - Downloading/unpacking jsonschema==2.5.1 10:31:34 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:31:34 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:31:34 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:31:34 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:31:34 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:31:34 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:31:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:31:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:36 INFO - Downloading functools32-3.2.3-2.tar.gz 10:31:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:31:36 INFO - warning: no files found matching '*.txt' 10:31:36 INFO - no previously-included directories found matching 'build' 10:31:36 INFO - no previously-included directories found matching 'dist' 10:31:36 INFO - no previously-included directories found matching '.git*' 10:31:36 INFO - Installing collected packages: jsonschema, functools32 10:31:36 INFO - Running setup.py install for functools32 10:31:36 INFO - warning: no files found matching '*.txt' 10:31:36 INFO - no previously-included directories found matching 'build' 10:31:36 INFO - no previously-included directories found matching 'dist' 10:31:36 INFO - no previously-included directories found matching '.git*' 10:31:36 INFO - Successfully installed jsonschema functools32 10:31:36 INFO - Cleaning up... 10:31:36 INFO - Return code: 0 10:31:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:36 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 0x1443030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1701570>, '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 0x1702470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702900>, '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': '6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956', '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:31:36 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:31:36 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:31:36 INFO - Using env: {'DISPLAY': ':0', 10:31:36 INFO - 'HOME': '/home/cltbld', 10:31:36 INFO - 'LANG': 'en_US.UTF-8', 10:31:36 INFO - 'LANGUAGE': 'en_US:en', 10:31:36 INFO - 'LOGNAME': 'cltbld', 10:31:36 INFO - 'MAIL': '/var/mail/cltbld', 10:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:36 INFO - 'MOZ_NO_REMOTE': '1', 10:31:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:36 INFO - 'NO_EM_RESTART': '1', 10:31:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:36 INFO - 'PWD': '/builds/slave/test', 10:31:36 INFO - 'SHELL': '/bin/bash', 10:31:36 INFO - 'SHLVL': '1', 10:31:36 INFO - 'TERM': 'linux', 10:31:36 INFO - 'TMOUT': '86400', 10:31:36 INFO - 'USER': 'cltbld', 10:31:36 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956', 10:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:36 INFO - '_': '/tools/buildbot/bin/python'} 10:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:31:36 INFO - Cleaning up... 10:31:36 INFO - Return code: 0 10:31:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:36 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 0x1443030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1701570>, '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 0x1702470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702900>, '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': '6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956', '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:31:36 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:31:36 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:31:36 INFO - Using env: {'DISPLAY': ':0', 10:31:36 INFO - 'HOME': '/home/cltbld', 10:31:36 INFO - 'LANG': 'en_US.UTF-8', 10:31:36 INFO - 'LANGUAGE': 'en_US:en', 10:31:36 INFO - 'LOGNAME': 'cltbld', 10:31:36 INFO - 'MAIL': '/var/mail/cltbld', 10:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:36 INFO - 'MOZ_NO_REMOTE': '1', 10:31:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:36 INFO - 'NO_EM_RESTART': '1', 10:31:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:36 INFO - 'PWD': '/builds/slave/test', 10:31:36 INFO - 'SHELL': '/bin/bash', 10:31:36 INFO - 'SHLVL': '1', 10:31:36 INFO - 'TERM': 'linux', 10:31:36 INFO - 'TMOUT': '86400', 10:31:36 INFO - 'USER': 'cltbld', 10:31:36 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956', 10:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:36 INFO - '_': '/tools/buildbot/bin/python'} 10:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:36 INFO - Downloading/unpacking blobuploader==1.2.4 10:31:36 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:31:36 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:31:36 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:31:36 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:31:36 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:31:36 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:31:38 INFO - Downloading blobuploader-1.2.4.tar.gz 10:31:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:31:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:31:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:31:39 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:31:39 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:31:39 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:31:39 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:31:39 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:31:39 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:31:39 INFO - Downloading docopt-0.6.1.tar.gz 10:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:31:39 INFO - Installing collected packages: blobuploader, requests, docopt 10:31:39 INFO - Running setup.py install for blobuploader 10:31:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:31:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:31:39 INFO - Running setup.py install for requests 10:31:39 INFO - Running setup.py install for docopt 10:31:40 INFO - Successfully installed blobuploader requests docopt 10:31:40 INFO - Cleaning up... 10:31:40 INFO - Return code: 0 10:31:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:40 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 0x1443030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1701570>, '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 0x1702470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702900>, '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': '6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956', '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:31:40 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:31:40 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:31:40 INFO - Using env: {'DISPLAY': ':0', 10:31:40 INFO - 'HOME': '/home/cltbld', 10:31:40 INFO - 'LANG': 'en_US.UTF-8', 10:31:40 INFO - 'LANGUAGE': 'en_US:en', 10:31:40 INFO - 'LOGNAME': 'cltbld', 10:31:40 INFO - 'MAIL': '/var/mail/cltbld', 10:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:40 INFO - 'MOZ_NO_REMOTE': '1', 10:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:40 INFO - 'NO_EM_RESTART': '1', 10:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:40 INFO - 'PWD': '/builds/slave/test', 10:31:40 INFO - 'SHELL': '/bin/bash', 10:31:40 INFO - 'SHLVL': '1', 10:31:40 INFO - 'TERM': 'linux', 10:31:40 INFO - 'TMOUT': '86400', 10:31:40 INFO - 'USER': 'cltbld', 10:31:40 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956', 10:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:40 INFO - '_': '/tools/buildbot/bin/python'} 10:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:31:40 INFO - Running setup.py (path:/tmp/pip-0UBoTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:31:40 INFO - Running setup.py (path:/tmp/pip-QMT8Lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:31:40 INFO - Running setup.py (path:/tmp/pip-A3PojL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:31:40 INFO - Running setup.py (path:/tmp/pip-qD5LHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:31:40 INFO - Running setup.py (path:/tmp/pip-c7C9IE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:31:40 INFO - Running setup.py (path:/tmp/pip-ghOqlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:31:40 INFO - Running setup.py (path:/tmp/pip-IjZxqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:31:40 INFO - Running setup.py (path:/tmp/pip-n9kzUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:31:40 INFO - Running setup.py (path:/tmp/pip-TO2shi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:31:40 INFO - Running setup.py (path:/tmp/pip-yFuEhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:31:41 INFO - Running setup.py (path:/tmp/pip-Xari1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:31:41 INFO - Running setup.py (path:/tmp/pip-QusS2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:31:41 INFO - Running setup.py (path:/tmp/pip-c3Xs9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:31:41 INFO - Running setup.py (path:/tmp/pip-fUUtuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:41 INFO - Running setup.py (path:/tmp/pip-ZqYIDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:31:41 INFO - Running setup.py (path:/tmp/pip-CdqMP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:31:41 INFO - Running setup.py (path:/tmp/pip-MCQYOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:31:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:31:41 INFO - Running setup.py install for manifestparser 10:31:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:31:41 INFO - Running setup.py install for mozcrash 10:31:41 INFO - Running setup.py install for mozdebug 10:31:41 INFO - Running setup.py install for mozdevice 10:31:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:31:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:31:41 INFO - Running setup.py install for mozfile 10:31:42 INFO - Running setup.py install for mozhttpd 10:31:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:31:42 INFO - Running setup.py install for mozinfo 10:31:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:31:42 INFO - Running setup.py install for mozInstall 10:31:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:31:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:31:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:31:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:31:42 INFO - Running setup.py install for mozleak 10:31:42 INFO - Running setup.py install for mozlog 10:31:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:31:42 INFO - Running setup.py install for moznetwork 10:31:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:31:42 INFO - Running setup.py install for mozprocess 10:31:42 INFO - Running setup.py install for mozprofile 10:31:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:31:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:31:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:31:42 INFO - Running setup.py install for mozrunner 10:31:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:31:43 INFO - Running setup.py install for mozscreenshot 10:31:43 INFO - Running setup.py install for moztest 10:31:43 INFO - Running setup.py install for mozversion 10:31:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:31:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:31:43 INFO - Cleaning up... 10:31:43 INFO - Return code: 0 10:31:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31:43 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:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:43 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:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:43 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 0x1443030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1701570>, '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 0x1702470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702900>, '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': '6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956', '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:31:43 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:31:43 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:31:43 INFO - Using env: {'DISPLAY': ':0', 10:31:43 INFO - 'HOME': '/home/cltbld', 10:31:43 INFO - 'LANG': 'en_US.UTF-8', 10:31:43 INFO - 'LANGUAGE': 'en_US:en', 10:31:43 INFO - 'LOGNAME': 'cltbld', 10:31:43 INFO - 'MAIL': '/var/mail/cltbld', 10:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:43 INFO - 'MOZ_NO_REMOTE': '1', 10:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:43 INFO - 'NO_EM_RESTART': '1', 10:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:43 INFO - 'PWD': '/builds/slave/test', 10:31:43 INFO - 'SHELL': '/bin/bash', 10:31:43 INFO - 'SHLVL': '1', 10:31:43 INFO - 'TERM': 'linux', 10:31:43 INFO - 'TMOUT': '86400', 10:31:43 INFO - 'USER': 'cltbld', 10:31:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956', 10:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:43 INFO - '_': '/tools/buildbot/bin/python'} 10:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:31:43 INFO - Running setup.py (path:/tmp/pip-TwghzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:31:43 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:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:31:43 INFO - Running setup.py (path:/tmp/pip-xxQrWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:31:43 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:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:31:43 INFO - Running setup.py (path:/tmp/pip-O4hLyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:31:43 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:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:31:43 INFO - Running setup.py (path:/tmp/pip-Sp_fM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:31:43 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:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:31:43 INFO - Running setup.py (path:/tmp/pip-T3nxbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:31:43 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:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:31:43 INFO - Running setup.py (path:/tmp/pip-FPB97b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:31:43 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:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:31:43 INFO - Running setup.py (path:/tmp/pip-6MPtur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:31:44 INFO - Running setup.py (path:/tmp/pip-kRdfBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:31:44 INFO - Running setup.py (path:/tmp/pip-l9sJGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:31:44 INFO - Running setup.py (path:/tmp/pip-5Fvy4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:31:44 INFO - Running setup.py (path:/tmp/pip-Q3rPdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:31:44 INFO - Running setup.py (path:/tmp/pip-TfkTiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:31:44 INFO - Running setup.py (path:/tmp/pip-XV5QZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:31:44 INFO - Running setup.py (path:/tmp/pip-y6vWvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:44 INFO - Running setup.py (path:/tmp/pip-Qono7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:31:44 INFO - Running setup.py (path:/tmp/pip-O_qGOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:31:44 INFO - Running setup.py (path:/tmp/pip-O0nPPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:31:44 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:31:44 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:31:44 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:31:44 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:31:44 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:31:44 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:31:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:31:44 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:31:44 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:31:44 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:31:44 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:31:44 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:31:44 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:31:46 INFO - Downloading blessings-1.6.tar.gz 10:31:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:31:46 INFO - Installing collected packages: blessings 10:31:46 INFO - Running setup.py install for blessings 10:31:46 INFO - Successfully installed blessings 10:31:46 INFO - Cleaning up... 10:31:46 INFO - Return code: 0 10:31:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:31:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:31:47 INFO - Reading from file tmpfile_stdout 10:31:47 INFO - Current package versions: 10:31:47 INFO - argparse == 1.2.1 10:31:47 INFO - blessings == 1.6 10:31:47 INFO - blobuploader == 1.2.4 10:31:47 INFO - docopt == 0.6.1 10:31:47 INFO - functools32 == 3.2.3-2 10:31:47 INFO - jsonschema == 2.5.1 10:31:47 INFO - manifestparser == 1.1 10:31:47 INFO - mozInstall == 1.12 10:31:47 INFO - mozcrash == 0.17 10:31:47 INFO - mozdebug == 0.1 10:31:47 INFO - mozdevice == 0.48 10:31:47 INFO - mozfile == 1.2 10:31:47 INFO - mozhttpd == 0.7 10:31:47 INFO - mozinfo == 0.9 10:31:47 INFO - mozleak == 0.1 10:31:47 INFO - mozlog == 3.3 10:31:47 INFO - moznetwork == 0.27 10:31:47 INFO - mozprocess == 0.23 10:31:47 INFO - mozprofile == 0.28 10:31:47 INFO - mozrunner == 6.12 10:31:47 INFO - mozscreenshot == 0.1 10:31:47 INFO - mozsystemmonitor == 0.3 10:31:47 INFO - moztest == 0.7 10:31:47 INFO - mozversion == 1.4 10:31:47 INFO - psutil == 3.1.1 10:31:47 INFO - requests == 1.2.3 10:31:47 INFO - wsgiref == 0.1.2 10:31:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:47 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 0x1443030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1701570>, '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 0x1702470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702900>, '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': '6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956', '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:31:47 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:31:47 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:31:47 INFO - Using env: {'DISPLAY': ':0', 10:31:47 INFO - 'HOME': '/home/cltbld', 10:31:47 INFO - 'LANG': 'en_US.UTF-8', 10:31:47 INFO - 'LANGUAGE': 'en_US:en', 10:31:47 INFO - 'LOGNAME': 'cltbld', 10:31:47 INFO - 'MAIL': '/var/mail/cltbld', 10:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:47 INFO - 'MOZ_NO_REMOTE': '1', 10:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:47 INFO - 'NO_EM_RESTART': '1', 10:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:47 INFO - 'PWD': '/builds/slave/test', 10:31:47 INFO - 'SHELL': '/bin/bash', 10:31:47 INFO - 'SHLVL': '1', 10:31:47 INFO - 'TERM': 'linux', 10:31:47 INFO - 'TMOUT': '86400', 10:31:47 INFO - 'USER': 'cltbld', 10:31:47 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956', 10:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:47 INFO - '_': '/tools/buildbot/bin/python'} 10:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:47 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:31:47 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:31:47 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:31:47 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:31:47 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:31:47 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:31:47 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:31:47 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:31:47 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:31:47 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:31:47 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:31:47 INFO - Cleaning up... 10:31:47 INFO - Return code: 0 10:31:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:47 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 0x1443030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1701570>, '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 0x1702470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702900>, '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': '6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956', '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:31:47 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:31:47 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:31:47 INFO - Using env: {'DISPLAY': ':0', 10:31:47 INFO - 'HOME': '/home/cltbld', 10:31:47 INFO - 'LANG': 'en_US.UTF-8', 10:31:47 INFO - 'LANGUAGE': 'en_US:en', 10:31:47 INFO - 'LOGNAME': 'cltbld', 10:31:47 INFO - 'MAIL': '/var/mail/cltbld', 10:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:47 INFO - 'MOZ_NO_REMOTE': '1', 10:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:47 INFO - 'NO_EM_RESTART': '1', 10:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:47 INFO - 'PWD': '/builds/slave/test', 10:31:47 INFO - 'SHELL': '/bin/bash', 10:31:47 INFO - 'SHLVL': '1', 10:31:47 INFO - 'TERM': 'linux', 10:31:47 INFO - 'TMOUT': '86400', 10:31:47 INFO - 'USER': 'cltbld', 10:31:47 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956', 10:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:47 INFO - '_': '/tools/buildbot/bin/python'} 10:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:31:47 INFO - Cleaning up... 10:31:47 INFO - Return code: 0 10:31:47 INFO - Running post-action listener: _resource_record_post_action 10:31:47 INFO - Running post-action listener: _start_resource_monitoring 10:31:47 INFO - Starting resource monitoring. 10:31:47 INFO - [mozharness: 2016-08-04 17:31:47.611666Z] Finished create-virtualenv step (success) 10:31:47 INFO - [mozharness: 2016-08-04 17:31:47.612146Z] Running install step. 10:31:47 INFO - Running pre-action listener: _resource_record_pre_action 10:31:47 INFO - Running main action method: install 10:31:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:31:47 INFO - Reading from file tmpfile_stdout 10:31:47 INFO - Detecting whether we're running mozinstall >=1.0... 10:31:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:31:47 INFO - Reading from file tmpfile_stdout 10:31:47 INFO - Output received: 10:31:47 INFO - Usage: mozinstall [options] installer 10:31:47 INFO - Options: 10:31:47 INFO - -h, --help show this help message and exit 10:31:47 INFO - -d DEST, --destination=DEST 10:31:47 INFO - Directory to install application into. [default: 10:31:47 INFO - "/builds/slave/test"] 10:31:47 INFO - --app=APP Application being installed. [default: firefox] 10:31:47 INFO - mkdir: /builds/slave/test/build/application 10:31:47 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:31:47 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:32:04 INFO - Reading from file tmpfile_stdout 10:32:04 INFO - Output received: 10:32:04 INFO - /builds/slave/test/build/application/firefox/firefox 10:32:04 INFO - Running post-action listener: _resource_record_post_action 10:32:04 INFO - [mozharness: 2016-08-04 17:32:04.767281Z] Finished install step (success) 10:32:04 INFO - [mozharness: 2016-08-04 17:32:04.767528Z] Running run-tests step. 10:32:04 INFO - Running pre-action listener: _resource_record_pre_action 10:32:04 INFO - Running main action method: run_tests 10:32:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:32:04 INFO - Python 2.7.3 10:32:04 INFO - Return code: 0 10:32:04 INFO - grabbing minidump binary from tooltool 10:32: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:32:04 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 0x1701570>, '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 0x1702470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:32:04 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:32:04 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:32:04 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:32:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:32:04 INFO - Return code: 0 10:32:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:32:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:32:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:32:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:32:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:32:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:32:04 INFO - Using env: {'DISPLAY': ':0', 10:32:04 INFO - 'HOME': '/home/cltbld', 10:32:04 INFO - 'LANG': 'en_US.UTF-8', 10:32:04 INFO - 'LANGUAGE': 'en_US:en', 10:32:04 INFO - 'LOGNAME': 'cltbld', 10:32:04 INFO - 'MAIL': '/var/mail/cltbld', 10:32:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:32:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:32:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:04 INFO - 'MOZ_NO_REMOTE': '1', 10:32:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:32:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:04 INFO - 'NO_EM_RESTART': '1', 10:32:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:04 INFO - 'PWD': '/builds/slave/test', 10:32:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:32:04 INFO - 'SHELL': '/bin/bash', 10:32:04 INFO - 'SHLVL': '1', 10:32:04 INFO - 'TERM': 'linux', 10:32:04 INFO - 'TMOUT': '86400', 10:32:04 INFO - 'USER': 'cltbld', 10:32:04 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956', 10:32:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:04 INFO - '_': '/tools/buildbot/bin/python'} 10:32:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:32:05 INFO - mozversion application_buildid: 20160804073002 10:32:05 INFO - mozversion application_changeset: d2c3da5ac021138cc92099d2c10b6a591929b6c4 10:32:05 INFO - mozversion application_display_name: Nightly 10:32:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:32:05 INFO - mozversion application_name: Firefox 10:32:05 INFO - mozversion application_remotingname: firefox 10:32:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:32:05 INFO - mozversion application_vendor: Mozilla 10:32:05 INFO - mozversion application_version: 51.0a1 10:32:05 INFO - mozversion platform_buildid: 20160804073002 10:32:05 INFO - mozversion platform_changeset: d2c3da5ac021138cc92099d2c10b6a591929b6c4 10:32:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:32:05 INFO - mozversion platform_version: 51.0a1 10:32:05 INFO - using testdate: 1470331925 10:32:05 INFO - actual date: 1470331925 10:32:05 INFO - starting webserver on 'localhost:58955' 10:32:05 INFO - SUITE-START | Running 2 tests 10:32:05 INFO - TEST-START | dromaeo_css 10:32:05 INFO - operating with platform_type : linux_ 10:32:05 INFO - Initialising browser for dromaeo_css test... 10:32:05 INFO - TEST-INFO | started process 28697 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRA7u0X/profile http://localhost:58955/getInfo.html) 10:32:09 INFO - PROCESS | 28697 | __metrics Screen width/height:1600/1200 10:32:09 INFO - PROCESS | 28697 | colorDepth:24 10:32:09 INFO - PROCESS | 28697 | Browser inner width/height: 1024/697 10:32:09 INFO - PROCESS | 28697 | __metrics 10:32:10 ERROR - PROCESS | 28697 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 10:32:10 INFO - TEST-INFO | 28697: exit 0 10:32:10 INFO - Browser initialized. 10:32:10 INFO - Running cycle 1/1 for dromaeo_css test... 10:32:10 INFO - TEST-INFO | started process 28817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRA7u0X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:32:22 INFO - PROCESS | 28817 | RSS: Main: 163729408 10:32:22 INFO - PROCESS | 28817 | 10:33:12 INFO - PROCESS | 28817 | 1470331992251 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:35:21 INFO - PROCESS | 28817 | Cycle 1(1): loaded http://localhost:58955/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58955/tests/dromaeo/cssquery-ext.html) 10:35:22 INFO - PROCESS | 28817 | RSS: Main: 166957056 10:35:22 INFO - PROCESS | 28817 | 10:38:24 INFO - PROCESS | 28817 | Cycle 1(1): loaded http://localhost:58955/tests/dromaeo/cssquery-ext.html (next: http://localhost:58955/tests/dromaeo/cssquery-jquery.html) 10:38:25 INFO - PROCESS | 28817 | RSS: Main: 166694912 10:38:25 INFO - PROCESS | 28817 | 10:41:27 INFO - PROCESS | 28817 | Cycle 1(1): loaded http://localhost:58955/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58955/tests/dromaeo/cssquery-mootools.html) 10:41:28 INFO - PROCESS | 28817 | RSS: Main: 170086400 10:41:28 INFO - PROCESS | 28817 | 10:44:29 INFO - PROCESS | 28817 | Cycle 1(1): loaded http://localhost:58955/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58955/tests/dromaeo/cssquery-prototype.html) 10:44:30 INFO - PROCESS | 28817 | RSS: Main: 164675584 10:44:30 INFO - PROCESS | 28817 | 10:47:33 INFO - PROCESS | 28817 | Cycle 1(1): loaded http://localhost:58955/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58955/tests/dromaeo/cssquery-yui.html) 10:47:33 INFO - PROCESS | 28817 | RSS: Main: 167002112 10:47:33 INFO - PROCESS | 28817 | 10:50:36 INFO - PROCESS | 28817 | Cycle 1(1): loaded http://localhost:58955/tests/dromaeo/cssquery-yui.html (next: http://localhost:58955/tests/dromaeo/cssquery-dojo.html) 10:50:36 INFO - PROCESS | 28817 | RSS: Main: 170098688 10:50:36 INFO - PROCESS | 28817 | 10:50:36 INFO - PROCESS | 28817 | __start_tp_report 10:50:36 INFO - PROCESS | 28817 | _x_x_mozilla_page_load 10:50:36 INFO - PROCESS | 28817 | _x_x_mozilla_page_load_details 10:50:36 INFO - PROCESS | 28817 | |i|pagename|runs| 10:50:36 INFO - PROCESS | 28817 | |0;dojo.html;3014.8643311051;3029.091272618214;3064.3718037802255;3065.233691577105;3065.524843649235;5167.534921857032;5217.9739101304485;5283.603729720272;5291.444398338177;5318.095923692972;5248.343957005374;5305.4164041955355;5305.522502974732;5317.548008419289;5324.946750532494;4821.421429428456;4826.396700412449;4845.079434907374;4862.878428039301;4930.728809915453;4772.260299653542;4837.201861692834;4860.198067318888;4897;4933.45731969483;4964.801407943678;4999.125153098194;5001.049800537904;5007.949920500785;5015.5486006259425;4741.95258047422;4776.546228108359;4815.542523460265;4851.902961940777;4857.465678775332;4826.372571565709;4843.321934929113;4846.854594362175;4886.486918873503;4888.242322440027;5250.474952504757;5316.840494785162;5323.920141197885;5331.973340133313;5342.572594192456;5497.39528651848;5507.173923911405;5548.750306236229;5575.972120139414;5707.71461426927;5616.297962754656;5617.634853734494;5620.325560932673;5637.436256374371;5657.434256574351;5231.267622532849;5234;5235.136202526579;5244.187150991603;5283.867903302371;5539.667619942817;5713.942860571424;5760.164776107441;5800.767969281266;5803.448672376117;5587.329520457572;5595.860103497445;5597.692126932976;5608.10270356741;5626;5668.348139963874;5672.4611161940375;5681.204631351614;5683.403242659544;5693.629914055573;5471.671699698031;5559.054960656698;5579.330480342385;5608.214849921014;5666.093425052054;5426.70153141581;5548.9722551386985;5562.860928476821;5596.97201513998;5619.8876022480135;4214.726042807208;4280.336547835091;4284;4292.042004678271;4300.935485967713;3812.1041555234497;3837.597052309523;3841.654251117357;3865.207632435344;3880.3209438348176;5475.260839786658;5487.122060470306;5508.14623733322;5522.641028333145;5531.778728850801;5703.9429605704245;5746.310442746813;5754.510866576305;5757.712114394263;5762.423757624204;5336.839894803162;5496.395396506381;5498.1752737088955;5505.724713764296;5513.145462453326;4872.3909511311085;4893.339399181065;4897.657163998557;4904.681195722266;4912.361393018885;5861.384554621789;5872;5879.323877754027;5883.735231914574;5937.198478205387;5561.054620714407;5677.602567820213;5701.087825947994;5711.257536520392;5716.685582293014;5868.031774757117;5897.941020589739;5927.525797936241;5933.792317268875;5973.104034394702;5609.270794796814;5616.6068375213345;5627.18405831144;5652.830415087554;5654.971725141348;5530.308711411074;5696.487316141567;5738.139279108167;5754.367019627922;5757.913631295618;5536.750846211849;5540.473655002768;5589.217509548747;5618.129189975561;5650.576206784425;5563.610547261653;5570.972145139248;5575.498205161555;5582.8325150245555;5585.69278689676;5352.384475785178;5487.094629386106;5496.835094947158;5513.917291240715;5565.081761509306;5513.145462453326;5639.492445679908;5658.773649053992;5661.971690141523;5686.971565142313;5494.560435165097;5504.4770746778995;5505.311836020497;5555.138953462219;5555.333359996826 10:50:36 INFO - PROCESS | 28817 | |1;ext.html;587.0167469488606;588.5879884081143;608.0544752909226;621.0963048764049;649.7628365646541;39797.40303895444;40697.59302406975;44058.779706101464;44149.55850441503;44264;44466;45281;45424.54575454244;45606.54393456064;45634.7718261409;8777.34169937254;9022.413543119676;9025.729228123168;9025.909740902573;9033.593488293043;8923.553822308892;8969.327300452493;9050.5022223778;9050.637974481013;9052.41159324645;8982.910170898305;9017.639294428214;9098.63605455781;9099.681511147111;9104.8634270486;9015.233705135071;9056.049114842912;9067.909320906772;9072.22886054683;9088.50013249271;8852.557372131432;8872.11278872114;8884.422512536665;8911.331650126202;8931.347700675331;42809.1438171238;43302.35046474305;43326.35010474845;43330.56669433297;43362.181458205116;3511.10466830959;3589.856405743767;3611.855525778966;3772.9056773580605;4464.1071785643;33446.331073378395;33686.49470257948;33758.83120584406;34033.48949765755;34252.82873585641;3926.2736393767245;3965.8215380307665;3967.504061992251;4028.798560071985;4168.7081904266715;357486;358615;358671;359116;360334;58566;58721.119183212286;59191;59357;59582;62653.68673156696;63104.68447657732;63113;63123.36876631175;63278;15746;15996.280167392495;16192.595185120466;16676.74984875228;16828.57928551796;12210.511579536897;12234.632961011184;12322.199057061262;12326.260424374566;12329.753404931851;19854.50363740918;19879.304224352367;20077.59844803125;20112.39662810118;20230.69653955192;7125.1168113378335;7429.331360177502;7438.5536867788105;7581.801277629536;7611.238876112345;995.586831464934;1098.8901109888948;1149.0749946293315;1185.6443067079842;1213.8179273108929;33688.663113369046;33981.15047123842;34300.48549271763;34436.48345274823;34500.854768815014;1088.6570730219955;1111.6887271563976;1167.048855183023;1178.4402408855724;1218.561317925546;17583.91208043977;17736.467905962585;18000;18061;18130;590137;591181;592792;593857;598698;40941.59058409378;41054.58945410568;41364.37953430701;41452.37821432681;60010;1342.2684636872928;1360.6054244269249;1364.570160399471;1367.2343487646751;1378.2626294932163;31951;32888;33560;33659.26458330229;34013.82993085019;52536.21195682144;52629;52775.73612131915;52777.208341875674;52820;465246;465580;466969;467343.6632816814;469794;27849.860750696116;29540.113796586138;29848;30085.247868803453;30089.849550752107;48897;49766.25350619816;49820.25269620886;51967.74016130046;53899.46100538944;40597.1880562393;42534.57465425306;42689;43716.12567748691;44973.55026449694;42430.57569424266;43467;43678.56321436872;44252.612448887434;44982.55017449784;37061.44407833939;43026.569734302255;43054;43419.131617368104;44252.55747442613;35817.283654326246;37713;38703.41944870885;38989.610103898594;39467.80266098651;29149.7085029147;29284.707152928197;29544.261393465335;29604;30107.247318817204 10:50:36 INFO - PROCESS | 28817 | |2;jquery.html;366.9816259878838;383.7639851491333;385.06045249590994;386.79113278829436;401.50815251317124;16290.918545407287;17718.73421898671;19023;20586.588268234627;20848.583028339443;18505.907470462662;19403.12685929133;19710.21159153632;19778.901105494453;19888;5507.669539827603;5701.6864072476;5850.0932355484965;5860.531157507389;5862.589618726691;5378.704171270579;5628.155776633497;5731.226284451587;5758.596898217126;5767.077267637179;5662.745176467049;5701.74342154602;5712.428757124296;5713.028785106542;5714.685692286923;5452.754626041838;5698.886022279573;5704.515116215127;5811.6803575803315;5830.941690583082;5526.281583394133;5625.943740562624;5641.576881733887;5651.8587035324035;5736.483716465538;13867.306634668226;14146.151230926074;19675.40973770789;24073.27780166598;24165.275041748777;2229.9219527316627;2244.147224054865;2530.962035569468;2588.1717850287914;2876.2090425133047;9841.55712992917;9858.16205622523;9915;10017.449040302781;10029.548670309854;1875.317280989012;1882.6234753049446;1923.413358925527;1988.6321030609383;2045.2841505473114;80168;81198.18801812024;82322.17677823205;82433.58783206105;83216.58391708003;10874.401907894984;11059.834102488468;11477.71305717347;11623.476943537393;11738.647840564796;12101.636950891487;15473.613159671098;15568.455104071303;15589.064656120443;30127.397452050835;8727.825443491094;8873.378863479495;9159.90840091604;9697.224222062217;9905.455199963926;7791.92208077912;7890.7632771015815;7980.600969951479;8197.098319184885;8288.96387951506;8815.338849586178;8886.777830554158;9023.774405639911;9087.81824363509;9186.311026673025;3179.856906439216;3477.791332520057;3695.630436956337;3768.8304026318883;3784.0918179637238;932.5477143585356;964.2671569607149;974.2644303550916;1076.3703233608271;1117.3240189685123;20412.59174816525;20434.489137771376;21059.78940210609;21187.77057624979;21236.25673101434;995.9004099590128;1012.8075665623508;1027.3938376357985;1040.9895901041043;1066.648006157966;9345.345825792265;10861.555795970778;11079.833802492969;11483.196176267582;11502;524518.1322280169;529923;531559;542917;546000;86239.56880215558;102528.48735756273;106935;107319.4634026825;109894;1006.7030226083323;1007.6876168387677;1048.9527971241312;1053.7629033467563;1054.1356088007913;17095.91452042732;17866.660000500273;17976.730349044512;18139.911605303725;18224.908875455538;43621.781891090344;43876.56123438852;43927.78036109799;44089;44130.11739765251;56657.71671141618;61517.69241153944;62308.376916230256;62469.37530624636;62634;8187.222213889671;8291.58542072882;8376.790580235544;8450.154984501747;8460.576971151295;12476.688082798002;13913.443462261801;14061.648458788612;14167.929160354131;14358.282085895873;11330.37682927447;11559.653210403701;11582.768344633228;11842.348670823187;12170.75658486843;11640.343613125848;11744.647660570197;11771;12081.093917956365;12184.51261949512;11528.769424611293;11570.363630000431;11587.478563464496;11637.825432618687;11942;8218.096009438837;8219.547924863951;8230.588470576567;8395.580220989048;8824.91175088241;8532.360072994674;10926.672199834018;12143.939280303543;12168.2699038058;12234.204776689487 10:50:36 INFO - PROCESS | 28817 | |3;mootools.html;1498.325753410965;1525.2678714217175;1655.801303843538;1750.8599312055037;1802.9368972085972;7865.095514015876;8313.5011899286;8656.394052416334;8955.955220223897;9023.278137748972;8815.471071735701;9096.818063638722;9110.27117830572;9143.542822858846;9158.633654653806;2381.4284571702797;2429.8056155507516;2437.6343548467694;2439.4755127647554;2447.7429869863677;2374.347054560001;2410.915617953372;2454;2455.5702752018415;2465.5192237513693;2393.617021276596;2416.66166736657;2420.068273714624;2421.019487107724;2441.4384691520872;2302.574023805593;2335.836491445591;2342.390978345634;2367.171489978511;2407.1093695332665;2325.1978067566833;2339.263132113379;2345.7419683834764;2351.976480235193;2386.2602593196166;9150.176484116462;9184.540772961325;9198.310126740455;9274.211692006187;9287.814243715087;5304.469553044703;5404.432534583891;5406.243125962368;5412.648177868426;5435.347758268994;3443.2596991646915;3466.2027733621157;3493.8777142800136;3503.544539209912;3521.418965870628;1160.2052593973156;1166.7724793665238;1182.4619797991893;1189.6014835030276;2120.639491286485;12220.205686630341;12583.937080314632;12603.1807932485;12626.873731262662;12662.81005784914;4475.351074094238;4682.695624784378;4749.762511874393;4877.3903262092235;4912.606991440676;9865;9870.506474676238;9879.259055570861;9898.10917017472;9943.950280248697;5504.119340905436;5513;5514.91727624086;5517.282753242133;5518.392976772552;4376.584224498668;4872.1473742094995;5001.324821149098;5077.162268225775;5085.186370180753;3880.767153970771;4033.757974521538;4048.5344185418467;4049.6760259179196;4084;1342.9932850335686;1360.6054244269249;1370.787527933172;1379.6275005748591;1384.7507448659337;812.273015650989;901.8151278987792;933.5239028095721;944.6646440513656;945.7682867697458;5703.315602127771;5826.329972053183;5868.94131058684;5908.947849588626;6050.969745151334;943.6791490893129;972.5769290358575;979.4025644356936;983.0808194338316;1029.7580068683853;3874.108954940323;3909.5308562972627;3909.706771992112;3999.8200080996426;4020.19596080785;11091.44542772858;11498.195126341076;11536.5002549668;11560.94219528897;11619.477123529461;11476;11519.88480115205;11538.826917596243;11586.246893951866;11588.304701717923;8055.597220139087;8153.79615509617;8373.874391884005;8446.028706698808;8472.195141461429;5675.375708672125;5690.203371528072;5718.1708652246025;5810.738516766671;5945.791897283574;10176.796464070825;10350.430726309824;10418.270721049454;10434;10468.319559228627;9937.65218217359;10326.380417174994;10357.119644830274;10495.632652857113;10748.892511075102;7127.536710113826;7871.094824095073;8047.235512626291;8067.757967260992;8166.510009399455;8981.910180898107;9023.639054437748;9049.728508144766;9069;9080.137386948229;7510.211427800221;7519.812004699927;7671.309582137635;7739.651715672921;7961.840763184588;7506.24937506245;7561.621918903923;7618.162002179645;7686.846263074819;7809.687612495663;6831.487638427038;6908.032875397348;6912.758053468105;6924.238333783381;6925.653717314013;4859.586935110555;5013.498650134958;5044.621653375938;5086.847394578169;5111.974440127776;4828.806847726192;4889.437714662859;4963.627727920348;5002.449730529712;5017.974910125426 10:50:36 INFO - PROCESS | 28817 | |4;prototype.html;316.58603150973823;323.3000553801021;330.37229264397655;331.2943430493049;335.8387973772589;5340.225667278242;5453.945460545393;5555.472230138135;5674.177244299579;5694.487496125348;5488.353493951809;5516.91724624131;5520.254765606642;5520.365158006831;5573.498385145336;4307.50463696675;4321.719088259253;4324.589164029412;4332.913341733163;4347.869563913087;4029.717919745619;4260.275753121961;4274.850380236692;4340.131973605276;4356.520782713899;4221.387898754679;4222.493300803892;4238.406623072772;4248.468941382327;4249.150169966004;4201.957980420188;4219.346001369792;4235.195312890556;4277.8288868445225;4291.54938731435;3526.365254254233;3736.084659258499;3744.2885851688093;3747.2880152770886;3780.6786423154067;5304.469553044703;5381.327334083239;5386;5400.756965936543;5431.158170483582;4900.142475066885;4900.950990490085;4920.4833492483485;4929.507049295078;4937;5449.591280653927;5723.856903577403;5728.140778883159;5767.846430713874;5775.422457754233;4070.61329173728;4081.571434999342;4082.346824508094;4124.298869192215;4127.8968025799295;6058.575899687024;6061.54538409621;6084.361142080063;6092.634441933498;6112.694365281763;4105.938410923838;4138.5654506276405;4202.495700515897;4203.201391735561;4223.345381465878;4195;4225.549181474737;4228.23891699497;4234.428352172417;4256.510501292391;4890.975545122252;4891.192953162688;4895;4907.386576677915;4909.165441874889;5557.194206840067;5810.709464526757;5843.824685259449;5906.763729450774;5922.548975500944;1502.3239542206052;1516.4768154986511;1518.3850540530882;1519.6352875310067;1522.87055600273;954.6754103604808;966.4587830814767;992.667456402099;1002.644061358222;1002.8367094170727;4974.452810190876;5023.6985780853265;5029.597632189416;5039.269305950616;5073.898522029539;5241.9737901310245;5285.867853303698;5297.761600727977;5327.840164795062;5386.676799392049;4993.650444468925;5057.595392368602;5092.388913330424;5275.920861187085;5677.716114194356;3176.920576985594;3208.6684026128896;3221;3222.8871989480253;3265.706086452231;6170.845728856725;6345.746170153235;6363.809085727436;6366.267879193952;6379.330170332141;6117.847053823601;6126.295476020315;6139.785107521305;6163.599366041193;6176.289726681399;6282.811515654537;6284.43440090385;6307.810765677037;6314.589551679126;6329.841753956096;5773.950247662187;5962.2709414269375;5998.610090344114;6003.6397816131175;6023.819285421444;5979.701014949148;5993.940060599338;6017.669028203316;6028.739222791453;6040.335563087969;6004.849878753066;6222.782202622887;6304.148939893055;6308.779192728416;6323.747050117944;4082.4488694025927;4156.397322388298;4196.580341965779;4209.6000879916355;4217.662586993095;6011.428914253139;6024.3674414187635;6046.183765191643;6061.454469097803;6068.241469816273;5784.82645520635;5808.361080281081;5899.646021238739;5942.286925568959;5944.970275148597;5760.308762948305;5818.196359128684;5820.534357251495;5851.853703657443;5898.292204935436;5814.622049566934;5822.301323841166;5827.3881242470625;5840.2115714379715;5850.94149058504;5585.860353491195;5882.7058647066615;5905.35041145465;5914.083317085859;5939;5802.564807639528;5829.842958105528;5843.853903652443;5855.209546711139;5870.735816888165 10:50:36 INFO - PROCESS | 28817 | |5;yui.html;649.9935000649994;672.0960308385223;677.6307654259921;724.2106104346261;760.2663429790251;15604.84395156048;15621.297041633125;15910.124943128123;15991.760123598155;16994.405195818148;15487.225638718048;15896.52310430686;15945.521634350987;15945.601359965978;15951.52145435636;813.5200231863184;835.2774849754949;835.6532039203723;837.6272558711375;838.6645341863242;671.2079745899837;800.2557621412085;823.9011318641772;833.7415401225609;834.486790623765;850.7405241401401;855.0423525651279;855.3713020929642;858.3133493205441;858.8282343531288;850.6597361055597;852.1180578101666;853.0829358439702;853.7609469348592;853.9829203415959;620.6431302001367;623.0996210475864;624.4629618528062;625.1560393468826;625.6871564217892;14334.42662293507;14367.712645747131;14380.64048398788;14427;14433.278336083154;15180.924095379452;15277.159756213403;15296;15393.23033848303;15562.221888905622;12441.377931103409;12525;12550.74898502025;12588.559400421032;12610.432530536147;3893.415987601854;3929.4105884117325;4030.375291829771;4034.406409468273;4109.404136400235;83310.58344708238;84978;85048.14951850464;85402.57298713467;85917.57041214754;11821.940890295493;11957.880421195676;12013.399330033639;12136.393180340947;12755.744885102245;20850.47873803137;21037.158513659284;21049.473763156042;21111.472213194793;21385;8859.911400885909;8860.601272942604;8977.50623715689;8986.775330616656;9197;4771.73755443454;4862.3922009748785;4867.9269810952865;4930.784179526525;5000.199968005175;3360.2103505676146;3429.091290807938;3449.862005519801;3464.8614055438006;3475.3223121491574;481.14278883509627;581.2443823030044;588.1824264272665;588.6203398807745;590.7991282963727;641.7336805225872;708.1431467923767;716.2801384608539;723.5260904107818;746.4998451037818;9407;9829.705108846745;10145.442000689885;10191.898081019242;10219.7445063874;542.4223202289548;632.8797528469576;699.6606645776794;710.36422401951;723.3020135569201;4510.864674059783;4512.435945506812;4568.817247310137;4576.427946506687;4643.094596553639;110992;117984;118717;119723;122140;98462.50768746111;99822;99895;101126;102825.48587257016;88681;89567.55216223878;89996;90809;93510.53244733733;8391.538465384463;8633.179847914438;8704.956475217583;8709.390342676204;8741.519216443157;50599.49400505948;50966.490335096176;51059.2341114891;51063.489365105874;52609.47390526199;66451.66774166099;79630;82020;82598;82901.58549207215;11737.119716021503;11821.468033938665;11860.22908510944;11969;12011.63965081049;14055;14139.64650883736;14188.21964791905;14245.786313205517;14256.572302830931;12727.236365817711;13550.796738049134;13668.589942301747;13704.862951370758;13983.860161398256;12296.20074695142;12404.25574465535;12421.254724716546;12537;12866.421011054712;11755.823662644896;11993.34036627959;12115.15193936416;12131.878681213075;12931.870681293067;9808.754781130528;10043.461122005661;10075.244356673133;10205.081542661195;10491.160707143563;8254.83490330202;8617.48295102296;8861;9046.803084341202;9389.671361502315 10:50:36 INFO - PROCESS | 28817 | __end_tp_report 10:50:36 INFO - PROCESS | 28817 | __start_cc_report 10:50:36 INFO - PROCESS | 28817 | _x_x_mozilla_cycle_collect,331 10:50:36 INFO - PROCESS | 28817 | __end_cc_report 10:50:36 INFO - PROCESS | 28817 | __startTimestamp1470333036302__endTimestamp 10:50:36 INFO - PROCESS | 28817 | 10:50:36 INFO - PROCESS | 28817 | ------- Summary: start ------- 10:50:36 INFO - PROCESS | 28817 | Number of tests: 6 10:50:36 INFO - PROCESS | 28817 | 10:50:36 INFO - PROCESS | 28817 | [#0] dojo.html Cycles:165 Average:5279.48 Median:5513.15 stddev:601.48 (10.9%) stddev-sans-first:576.49 10:50:36 INFO - PROCESS | 28817 | Values: 3014.9 3029.1 3064.4 3065.2 3065.5 5167.5 5218.0 5283.6 5291.4 5318.1 5248.3 5305.4 5305.5 5317.5 5324.9 4821.4 4826.4 4845.1 4862.9 4930.7 4772.3 4837.2 4860.2 4897.0 4933.5 4964.8 4999.1 5001.0 5007.9 5015.5 4742.0 4776.5 4815.5 4851.9 4857.5 4826.4 4843.3 4846.9 4886.5 4888.2 5250.5 5316.8 5323.9 5332.0 5342.6 5497.4 5507.2 5548.8 5576.0 5707.7 5616.3 5617.6 5620.3 5637.4 5657.4 5231.3 5234.0 5235.1 5244.2 5283.9 5539.7 5713.9 5760.2 5800.8 5803.4 5587.3 5595.9 5597.7 5608.1 5626.0 5668.3 5672.5 5681.2 5683.4 5693.6 5471.7 5559.1 5579.3 5608.2 5666.1 5426.7 5549.0 5562.9 5597.0 5619.9 4214.7 4280.3 4284.0 4292.0 4300.9 3812.1 3837.6 3841.7 3865.2 3880.3 5475.3 5487.1 5508.1 5522.6 5531.8 5703.9 5746.3 5754.5 5757.7 5762.4 5336.8 5496.4 5498.2 5505.7 5513.1 4872.4 4893.3 4897.7 4904.7 4912.4 5861.4 5872.0 5879.3 5883.7 5937.2 5561.1 5677.6 5701.1 5711.3 5716.7 5868.0 5897.9 5927.5 5933.8 5973.1 5609.3 5616.6 5627.2 5652.8 5655.0 5530.3 5696.5 5738.1 5754.4 5757.9 5536.8 5540.5 5589.2 5618.1 5650.6 5563.6 5571.0 5575.5 5582.8 5585.7 5352.4 5487.1 5496.8 5513.9 5565.1 5513.1 5639.5 5658.8 5662.0 5687.0 5494.6 5504.5 5505.3 5555.1 5555.3 10:50:36 INFO - PROCESS | 28817 | 10:50:36 INFO - PROCESS | 28817 | [#1] ext.html Cycles:180 Average:63310.02 Median:43040.28 stddev:128273.10 (298.0%) stddev-sans-first:128546.50 10:50:36 INFO - PROCESS | 28817 | Values: 587.0 588.6 608.1 621.1 649.8 39797.4 40697.6 44058.8 44149.6 44264.0 44466.0 45281.0 45424.5 45606.5 45634.8 8777.3 9022.4 9025.7 9025.9 9033.6 8923.6 8969.3 9050.5 9050.6 9052.4 8982.9 9017.6 9098.6 9099.7 9104.9 9015.2 9056.0 9067.9 9072.2 9088.5 8852.6 8872.1 8884.4 8911.3 8931.3 42809.1 43302.4 43326.4 43330.6 43362.2 3511.1 3589.9 3611.9 3772.9 4464.1 33446.3 33686.5 33758.8 34033.5 34252.8 3926.3 3965.8 3967.5 4028.8 4168.7 357486.0 358615.0 358671.0 359116.0 360334.0 58566.0 58721.1 59191.0 59357.0 59582.0 62653.7 63104.7 63113.0 63123.4 63278.0 15746.0 15996.3 16192.6 16676.7 16828.6 12210.5 12234.6 12322.2 12326.3 12329.8 19854.5 19879.3 20077.6 20112.4 20230.7 7125.1 7429.3 7438.6 7581.8 7611.2 995.6 1098.9 1149.1 1185.6 1213.8 33688.7 33981.2 34300.5 34436.5 34500.9 1088.7 1111.7 1167.0 1178.4 1218.6 17583.9 17736.5 18000.0 18061.0 18130.0 590137.0 591181.0 592792.0 593857.0 598698.0 40941.6 41054.6 41364.4 41452.4 60010.0 1342.3 1360.6 1364.6 1367.2 1378.3 31951.0 32888.0 33560.0 33659.3 34013.8 52536.2 52629.0 52775.7 52777.2 52820.0 465246.0 465580.0 466969.0 467343.7 469794.0 27849.9 29540.1 29848.0 30085.2 30089.8 48897.0 49766.3 49820.3 51967.7 53899.5 40597.2 42534.6 42689.0 43716.1 44973.6 42430.6 43467.0 43678.6 44252.6 44982.6 37061.4 43026.6 43054.0 43419.1 44252.6 35817.3 37713.0 38703.4 38989.6 39467.8 29149.7 29284.7 29544.3 29604.0 30107.2 10:50:36 INFO - PROCESS | 28817 | 10:50:36 INFO - PROCESS | 28817 | [#2] jquery.html Cycles:180 Average:30940.23 Median:3328.82 stddev:88225.27 (2650.3%) stddev-sans-first:88442.90 10:50:36 INFO - PROCESS | 28817 | Values: 367.0 383.8 385.1 386.8 401.5 16290.9 17718.7 19023.0 20586.6 20848.6 18505.9 19403.1 19710.2 19778.9 19888.0 5507.7 5701.7 5850.1 5860.5 5862.6 5378.7 5628.2 5731.2 5758.6 5767.1 5662.7 5701.7 5712.4 5713.0 5714.7 5452.8 5698.9 5704.5 5811.7 5830.9 5526.3 5625.9 5641.6 5651.9 5736.5 13867.3 14146.2 19675.4 24073.3 24165.3 2229.9 2244.1 2531.0 2588.2 2876.2 9841.6 9858.2 9915.0 10017.4 10029.5 1875.3 1882.6 1923.4 1988.6 2045.3 80168.0 81198.2 82322.2 82433.6 83216.6 10874.4 11059.8 11477.7 11623.5 11738.6 12101.6 15473.6 15568.5 15589.1 30127.4 8727.8 8873.4 9159.9 9697.2 9905.5 7791.9 7890.8 7980.6 8197.1 8289.0 8815.3 8886.8 9023.8 9087.8 9186.3 3179.9 3477.8 3695.6 3768.8 3784.1 932.5 964.3 974.3 1076.4 1117.3 20412.6 20434.5 21059.8 21187.8 21236.3 995.9 1012.8 1027.4 1041.0 1066.6 9345.3 10861.6 11079.8 11483.2 11502.0 524518.1 529923.0 531559.0 542917.0 546000.0 86239.6 102528.5 106935.0 107319.5 109894.0 1006.7 1007.7 1049.0 1053.8 1054.1 17095.9 17866.7 17976.7 18139.9 18224.9 43621.8 43876.6 43927.8 44089.0 44130.1 56657.7 61517.7 62308.4 62469.4 62634.0 8187.2 8291.6 8376.8 8450.2 8460.6 12476.7 13913.4 14061.6 14167.9 14358.3 11330.4 11559.7 11582.8 11842.3 12170.8 11640.3 11744.6 11771.0 12081.1 12184.5 11528.8 11570.4 11587.5 11637.8 11942.0 8218.1 8219.5 8230.6 8395.6 8824.9 8532.4 10926.7 12143.9 12168.3 12234.2 10:50:36 INFO - PROCESS | 28817 | 10:50:36 INFO - PROCESS | 28817 | [#3] mootools.html Cycles:180 Average:5896.22 Median:4982.48 stddev:3366.81 (67.6%) stddev-sans-first:3360.03 10:50:36 INFO - PROCESS | 28817 | Values: 1498.3 1525.3 1655.8 1750.9 1802.9 7865.1 8313.5 8656.4 8956.0 9023.3 8815.5 9096.8 9110.3 9143.5 9158.6 2381.4 2429.8 2437.6 2439.5 2447.7 2374.3 2410.9 2454.0 2455.6 2465.5 2393.6 2416.7 2420.1 2421.0 2441.4 2302.6 2335.8 2342.4 2367.2 2407.1 2325.2 2339.3 2345.7 2352.0 2386.3 9150.2 9184.5 9198.3 9274.2 9287.8 5304.5 5404.4 5406.2 5412.6 5435.3 3443.3 3466.2 3493.9 3503.5 3521.4 1160.2 1166.8 1182.5 1189.6 2120.6 12220.2 12583.9 12603.2 12626.9 12662.8 4475.4 4682.7 4749.8 4877.4 4912.6 9865.0 9870.5 9879.3 9898.1 9944.0 5504.1 5513.0 5514.9 5517.3 5518.4 4376.6 4872.1 5001.3 5077.2 5085.2 3880.8 4033.8 4048.5 4049.7 4084.0 1343.0 1360.6 1370.8 1379.6 1384.8 812.3 901.8 933.5 944.7 945.8 5703.3 5826.3 5868.9 5908.9 6051.0 943.7 972.6 979.4 983.1 1029.8 3874.1 3909.5 3909.7 3999.8 4020.2 11091.4 11498.2 11536.5 11560.9 11619.5 11476.0 11519.9 11538.8 11586.2 11588.3 8055.6 8153.8 8373.9 8446.0 8472.2 5675.4 5690.2 5718.2 5810.7 5945.8 10176.8 10350.4 10418.3 10434.0 10468.3 9937.7 10326.4 10357.1 10495.6 10748.9 7127.5 7871.1 8047.2 8067.8 8166.5 8981.9 9023.6 9049.7 9069.0 9080.1 7510.2 7519.8 7671.3 7739.7 7961.8 7506.2 7561.6 7618.2 7686.8 7809.7 6831.5 6908.0 6912.8 6924.2 6925.7 4859.6 5013.5 5044.6 5086.8 5112.0 4828.8 4889.4 4963.6 5002.4 5018.0 10:50:36 INFO - PROCESS | 28817 | 10:50:36 INFO - PROCESS | 28817 | [#4] prototype.html Cycles:180 Average:4864.50 Median:5415.96 stddev:1451.98 (26.8%) stddev-sans-first:1415.36 10:50:36 INFO - PROCESS | 28817 | Values: 316.6 323.3 330.4 331.3 335.8 5340.2 5453.9 5555.5 5674.2 5694.5 5488.4 5516.9 5520.3 5520.4 5573.5 4307.5 4321.7 4324.6 4332.9 4347.9 4029.7 4260.3 4274.9 4340.1 4356.5 4221.4 4222.5 4238.4 4248.5 4249.2 4202.0 4219.3 4235.2 4277.8 4291.5 3526.4 3736.1 3744.3 3747.3 3780.7 5304.5 5381.3 5386.0 5400.8 5431.2 4900.1 4901.0 4920.5 4929.5 4937.0 5449.6 5723.9 5728.1 5767.8 5775.4 4070.6 4081.6 4082.3 4124.3 4127.9 6058.6 6061.5 6084.4 6092.6 6112.7 4105.9 4138.6 4202.5 4203.2 4223.3 4195.0 4225.5 4228.2 4234.4 4256.5 4891.0 4891.2 4895.0 4907.4 4909.2 5557.2 5810.7 5843.8 5906.8 5922.5 1502.3 1516.5 1518.4 1519.6 1522.9 954.7 966.5 992.7 1002.6 1002.8 4974.5 5023.7 5029.6 5039.3 5073.9 5242.0 5285.9 5297.8 5327.8 5386.7 4993.7 5057.6 5092.4 5275.9 5677.7 3176.9 3208.7 3221.0 3222.9 3265.7 6170.8 6345.7 6363.8 6366.3 6379.3 6117.8 6126.3 6139.8 6163.6 6176.3 6282.8 6284.4 6307.8 6314.6 6329.8 5774.0 5962.3 5998.6 6003.6 6023.8 5979.7 5993.9 6017.7 6028.7 6040.3 6004.8 6222.8 6304.1 6308.8 6323.7 4082.4 4156.4 4196.6 4209.6 4217.7 6011.4 6024.4 6046.2 6061.5 6068.2 5784.8 5808.4 5899.6 5942.3 5945.0 5760.3 5818.2 5820.5 5851.9 5898.3 5814.6 5822.3 5827.4 5840.2 5850.9 5585.9 5882.7 5905.4 5914.1 5939.0 5802.6 5829.8 5843.9 5855.2 5870.7 10:50:36 INFO - PROCESS | 28817 | 10:50:36 INFO - PROCESS | 28817 | [#5] yui.html Cycles:180 Average:21261.29 Median:2671.77 stddev:31288.57 (1171.1%) stddev-sans-first:31338.07 10:50:36 INFO - PROCESS | 28817 | Values: 650.0 672.1 677.6 724.2 760.3 15604.8 15621.3 15910.1 15991.8 16994.4 15487.2 15896.5 15945.5 15945.6 15951.5 813.5 835.3 835.7 837.6 838.7 671.2 800.3 823.9 833.7 834.5 850.7 855.0 855.4 858.3 858.8 850.7 852.1 853.1 853.8 854.0 620.6 623.1 624.5 625.2 625.7 14334.4 14367.7 14380.6 14427.0 14433.3 15180.9 15277.2 15296.0 15393.2 15562.2 12441.4 12525.0 12550.7 12588.6 12610.4 3893.4 3929.4 4030.4 4034.4 4109.4 83310.6 84978.0 85048.1 85402.6 85917.6 11821.9 11957.9 12013.4 12136.4 12755.7 20850.5 21037.2 21049.5 21111.5 21385.0 8859.9 8860.6 8977.5 8986.8 9197.0 4771.7 4862.4 4867.9 4930.8 5000.2 3360.2 3429.1 3449.9 3464.9 3475.3 481.1 581.2 588.2 588.6 590.8 641.7 708.1 716.3 723.5 746.5 9407.0 9829.7 10145.4 10191.9 10219.7 542.4 632.9 699.7 710.4 723.3 4510.9 4512.4 4568.8 4576.4 4643.1 110992.0 117984.0 118717.0 119723.0 122140.0 98462.5 99822.0 99895.0 101126.0 102825.5 88681.0 89567.6 89996.0 90809.0 93510.5 8391.5 8633.2 8705.0 8709.4 8741.5 50599.5 50966.5 51059.2 51063.5 52609.5 66451.7 79630.0 82020.0 82598.0 82901.6 11737.1 11821.5 11860.2 11969.0 12011.6 14055.0 14139.6 14188.2 14245.8 14256.6 12727.2 13550.8 13668.6 13704.9 13983.9 12296.2 12404.3 12421.3 12537.0 12866.4 11755.8 11993.3 12115.2 12131.9 12931.9 9808.8 10043.5 10075.2 10205.1 10491.2 8254.8 8617.5 8861.0 9046.8 9389.7 10:50:36 INFO - PROCESS | 28817 | -------- Summary: end -------- 10:50:36 INFO - PROCESS | 28817 | 10:50:37 INFO - TEST-INFO | 28817: exit 0 10:50:37 INFO - TEST-OK | dromaeo_css | took 1112039ms 10:50:37 INFO - TEST-START | kraken 10:50:37 INFO - operating with platform_type : linux_ 10:50:37 INFO - Initialising browser for kraken test... 10:50:37 INFO - TEST-INFO | started process 29062 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpExwvNd/profile http://localhost:58955/getInfo.html) 10:50:41 INFO - PROCESS | 29062 | __metrics Screen width/height:1600/1200 10:50:41 INFO - PROCESS | 29062 | colorDepth:24 10:50:41 INFO - PROCESS | 29062 | Browser inner width/height: 1024/697 10:50:41 INFO - PROCESS | 29062 | __metrics 10:50:41 ERROR - PROCESS | 29062 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 10:50:42 INFO - TEST-INFO | 29062: exit 0 10:50:42 INFO - Browser initialized. 10:50:42 INFO - Running cycle 1/1 for kraken test... 10:50:42 INFO - TEST-INFO | started process 29179 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpExwvNd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:50:54 INFO - PROCESS | 29179 | RSS: Main: 164253696 10:50:54 INFO - PROCESS | 29179 | 10:50:57 INFO - PROCESS | 29179 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58955/tests/kraken/driver.html?testName=audio-beat-detection) 10:50:57 INFO - PROCESS | 29179 | RSS: Main: 169533440 10:50:57 INFO - PROCESS | 29179 | 10:51:00 INFO - PROCESS | 29179 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58955/tests/kraken/driver.html?testName=audio-dft) 10:51:01 INFO - PROCESS | 29179 | RSS: Main: 168632320 10:51:01 INFO - PROCESS | 29179 | 10:51:04 INFO - PROCESS | 29179 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58955/tests/kraken/driver.html?testName=audio-fft) 10:51:04 INFO - PROCESS | 29179 | RSS: Main: 163897344 10:51:04 INFO - PROCESS | 29179 | 10:51:06 INFO - PROCESS | 29179 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58955/tests/kraken/driver.html?testName=audio-oscillator) 10:51:07 INFO - PROCESS | 29179 | RSS: Main: 165740544 10:51:07 INFO - PROCESS | 29179 | 10:51:09 INFO - PROCESS | 29179 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58955/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:51:10 INFO - PROCESS | 29179 | RSS: Main: 165933056 10:51:10 INFO - PROCESS | 29179 | 10:51:13 INFO - PROCESS | 29179 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58955/tests/kraken/driver.html?testName=imaging-darkroom) 10:51:14 INFO - PROCESS | 29179 | RSS: Main: 166678528 10:51:14 INFO - PROCESS | 29179 | 10:51:17 INFO - PROCESS | 29179 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58955/tests/kraken/driver.html?testName=imaging-desaturate) 10:51:18 INFO - PROCESS | 29179 | RSS: Main: 162951168 10:51:18 INFO - PROCESS | 29179 | 10:51:21 INFO - PROCESS | 29179 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58955/tests/kraken/driver.html?testName=json-parse-financial) 10:51:21 INFO - PROCESS | 29179 | RSS: Main: 165072896 10:51:21 INFO - PROCESS | 29179 | 10:51:23 INFO - PROCESS | 29179 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58955/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:51:23 INFO - PROCESS | 29179 | RSS: Main: 165249024 10:51:23 INFO - PROCESS | 29179 | 10:51:25 INFO - PROCESS | 29179 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:51:26 INFO - PROCESS | 29179 | RSS: Main: 165236736 10:51:26 INFO - PROCESS | 29179 | 10:51:28 INFO - PROCESS | 29179 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:51:28 INFO - PROCESS | 29179 | RSS: Main: 165834752 10:51:28 INFO - PROCESS | 29179 | 10:51:31 INFO - PROCESS | 29179 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:51:32 INFO - PROCESS | 29179 | RSS: Main: 166428672 10:51:32 INFO - PROCESS | 29179 | 10:51:35 INFO - PROCESS | 29179 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:51:35 INFO - PROCESS | 29179 | RSS: Main: 166731776 10:51:35 INFO - PROCESS | 29179 | 10:51:37 INFO - PROCESS | 29179 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58955/tests/kraken/driver.html?testName=ai-astar) 10:51:37 INFO - PROCESS | 29179 | RSS: Main: 167497728 10:51:37 INFO - PROCESS | 29179 | 10:51:37 INFO - PROCESS | 29179 | __start_tp_report 10:51:37 INFO - PROCESS | 29179 | _x_x_mozilla_page_load 10:51:37 INFO - PROCESS | 29179 | _x_x_mozilla_page_load_details 10:51:37 INFO - PROCESS | 29179 | |i|pagename|runs| 10:51:37 INFO - PROCESS | 29179 | |0;ai-astar;104;115;107;111;115;112;114;111;112;112 10:51:37 INFO - PROCESS | 29179 | |1;audio-beat-detection;152;117;146;181;118;159;152;125;182;128 10:51:37 INFO - PROCESS | 29179 | |2;audio-dft;163;162;163;163;162;166;168;162;162;161 10:51:37 INFO - PROCESS | 29179 | |3;audio-fft;80;76;76;175;78;77;75;77;172;76 10:51:37 INFO - PROCESS | 29179 | |4;audio-oscillator;85;85;175;85;85;85;140;86;84;138 10:51:37 INFO - PROCESS | 29179 | |5;imaging-gaussian-blur;117;117;117;117;117;118;118;118;118;118 10:51:37 INFO - PROCESS | 29179 | |6;imaging-darkroom;147;148;148;148;147;148;149;148;146;147 10:51:37 INFO - PROCESS | 29179 | |7;imaging-desaturate;96;97;96;96;99;100;95;96;95;95 10:51:37 INFO - PROCESS | 29179 | |8;json-parse-financial;52;51;52;52;53;52;54;51;53;56 10:51:37 INFO - PROCESS | 29179 | |9;json-stringify-tinderbox;60;60;61;59;60;59;60;59;61;60 10:51:37 INFO - PROCESS | 29179 | |10;stanford-crypto-aes;84;83;77;78;77;85;78;76;82;78 10:51:37 INFO - PROCESS | 29179 | |11;stanford-crypto-ccm;136;132;137;138;135;130;125;134;126;138 10:51:37 INFO - PROCESS | 29179 | |12;stanford-crypto-pbkdf2;167;173;168;168;166;168;171;167;168;170 10:51:37 INFO - PROCESS | 29179 | |13;stanford-crypto-sha256-iterative;68;67;64;65;64;68;66;63;66;64 10:51:37 INFO - PROCESS | 29179 | __end_tp_report 10:51:37 INFO - PROCESS | 29179 | __start_cc_report 10:51:37 INFO - PROCESS | 29179 | _x_x_mozilla_cycle_collect,873 10:51:37 INFO - PROCESS | 29179 | __end_cc_report 10:51:37 INFO - PROCESS | 29179 | __startTimestamp1470333097624__endTimestamp 10:51:37 INFO - PROCESS | 29179 | 10:51:37 INFO - PROCESS | 29179 | ------- Summary: start ------- 10:51:37 INFO - PROCESS | 29179 | Number of tests: 14 10:51:37 INFO - PROCESS | 29179 | 10:51:37 INFO - PROCESS | 29179 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:3.47 (3.1%) stddev-sans-first:2.47 10:51:37 INFO - PROCESS | 29179 | Values: 104.0 115.0 107.0 111.0 115.0 112.0 114.0 111.0 112.0 112.0 10:51:37 INFO - PROCESS | 29179 | 10:51:37 INFO - PROCESS | 29179 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:152.00 stddev:23.93 (15.7%) stddev-sans-first:25.28 10:51:37 INFO - PROCESS | 29179 | Values: 152.0 117.0 146.0 181.0 118.0 159.0 152.0 125.0 182.0 128.0 10:51:37 INFO - PROCESS | 29179 | 10:51:37 INFO - PROCESS | 29179 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:2.15 (1.3%) stddev-sans-first:2.28 10:51:37 INFO - PROCESS | 29179 | Values: 163.0 162.0 163.0 163.0 162.0 166.0 168.0 162.0 162.0 161.0 10:51:37 INFO - PROCESS | 29179 | 10:51:37 INFO - PROCESS | 29179 | [#3] audio-fft Cycles:10 Average:96.20 Median:76.50 stddev:40.77 (53.3%) stddev-sans-first:42.82 10:51:37 INFO - PROCESS | 29179 | Values: 80.0 76.0 76.0 175.0 78.0 77.0 75.0 77.0 172.0 76.0 10:51:37 INFO - PROCESS | 29179 | 10:51:37 INFO - PROCESS | 29179 | [#4] audio-oscillator Cycles:10 Average:104.80 Median:85.00 stddev:33.36 (39.2%) stddev-sans-first:34.60 10:51:37 INFO - PROCESS | 29179 | Values: 85.0 85.0 175.0 85.0 85.0 85.0 140.0 86.0 84.0 138.0 10:51:37 INFO - PROCESS | 29179 | 10:51:37 INFO - PROCESS | 29179 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 10:51:37 INFO - PROCESS | 29179 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 10:51:37 INFO - PROCESS | 29179 | 10:51:37 INFO - PROCESS | 29179 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.84 (0.6%) stddev-sans-first:0.87 10:51:37 INFO - PROCESS | 29179 | Values: 147.0 148.0 148.0 148.0 147.0 148.0 149.0 148.0 146.0 147.0 10:51:37 INFO - PROCESS | 29179 | 10:51:37 INFO - PROCESS | 29179 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.72 (1.8%) stddev-sans-first:1.81 10:51:37 INFO - PROCESS | 29179 | Values: 96.0 97.0 96.0 96.0 99.0 100.0 95.0 96.0 95.0 95.0 10:51:37 INFO - PROCESS | 29179 | 10:51:37 INFO - PROCESS | 29179 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:52.50 stddev:1.51 (2.9%) stddev-sans-first:1.58 10:51:37 INFO - PROCESS | 29179 | Values: 52.0 51.0 52.0 52.0 53.0 52.0 54.0 51.0 53.0 56.0 10:51:37 INFO - PROCESS | 29179 | 10:51:37 INFO - PROCESS | 29179 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 10:51:37 INFO - PROCESS | 29179 | Values: 60.0 60.0 61.0 59.0 60.0 59.0 60.0 59.0 61.0 60.0 10:51:37 INFO - PROCESS | 29179 | 10:51:37 INFO - PROCESS | 29179 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:80.00 stddev:3.33 (4.2%) stddev-sans-first:3.16 10:51:37 INFO - PROCESS | 29179 | Values: 84.0 83.0 77.0 78.0 77.0 85.0 78.0 76.0 82.0 78.0 10:51:37 INFO - PROCESS | 29179 | 10:51:37 INFO - PROCESS | 29179 | [#11] stanford-crypto-ccm Cycles:10 Average:133.10 Median:135.50 stddev:4.75 (3.5%) stddev-sans-first:4.92 10:51:37 INFO - PROCESS | 29179 | Values: 136.0 132.0 137.0 138.0 135.0 130.0 125.0 134.0 126.0 138.0 10:51:37 INFO - PROCESS | 29179 | 10:51:37 INFO - PROCESS | 29179 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:168.00 stddev:2.12 (1.3%) stddev-sans-first:2.17 10:51:37 INFO - PROCESS | 29179 | Values: 167.0 173.0 168.0 168.0 166.0 168.0 171.0 167.0 168.0 170.0 10:51:37 INFO - PROCESS | 29179 | 10:51:37 INFO - PROCESS | 29179 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.78 (2.7%) stddev-sans-first:1.64 10:51:37 INFO - PROCESS | 29179 | Values: 68.0 67.0 64.0 65.0 64.0 68.0 66.0 63.0 66.0 64.0 10:51:37 INFO - PROCESS | 29179 | -------- Summary: end -------- 10:51:37 INFO - PROCESS | 29179 | 10:51:38 INFO - TEST-INFO | 29179: exit 0 10:51:38 INFO - TEST-OK | kraken | took 61462ms 10:51:38 INFO - SUITE-END | took 1173s 10:51:38 INFO - Completed test suite (00:19:33) 10:51:38 INFO - javascript benchmark 10:51:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7391.40903938105, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3014.8643311051, 3029.091272618214, 3064.3718037802255, 3065.233691577105, 3065.524843649235, 5167.534921857032, 5217.9739101304485, 5283.603729720272, 5291.444398338177, 5318.095923692972, 5248.343957005374, 5305.4164041955355, 5305.522502974732, 5317.548008419289, 5324.946750532494, 4821.421429428456, 4826.396700412449, 4845.079434907374, 4862.878428039301, 4930.728809915453, 4772.260299653542, 4837.201861692834, 4860.198067318888, 4897.0, 4933.45731969483, 4964.801407943678, 4999.125153098194, 5001.049800537904, 5007.949920500785, 5015.5486006259425, 4741.95258047422, 4776.546228108359, 4815.542523460265, 4851.902961940777, 4857.465678775332, 4826.372571565709, 4843.321934929113, 4846.854594362175, 4886.486918873503, 4888.242322440027, 5250.474952504757, 5316.840494785162, 5323.920141197885, 5331.973340133313, 5342.572594192456, 5497.39528651848, 5507.173923911405, 5548.750306236229, 5575.972120139414, 5707.71461426927, 5616.297962754656, 5617.634853734494, 5620.325560932673, 5637.436256374371, 5657.434256574351, 5231.267622532849, 5234.0, 5235.136202526579, 5244.187150991603, 5283.867903302371, 5539.667619942817, 5713.942860571424, 5760.164776107441, 5800.767969281266, 5803.448672376117, 5587.329520457572, 5595.860103497445, 5597.692126932976, 5608.10270356741, 5626.0, 5668.348139963874, 5672.4611161940375, 5681.204631351614, 5683.403242659544, 5693.629914055573, 5471.671699698031, 5559.054960656698, 5579.330480342385, 5608.214849921014, 5666.093425052054, 5426.70153141581, 5548.9722551386985, 5562.860928476821, 5596.97201513998, 5619.8876022480135, 4214.726042807208, 4280.336547835091, 4284.0, 4292.042004678271, 4300.935485967713, 3812.1041555234497, 3837.597052309523, 3841.654251117357, 3865.207632435344, 3880.3209438348176, 5475.260839786658, 5487.122060470306, 5508.14623733322, 5522.641028333145, 5531.778728850801, 5703.9429605704245, 5746.310442746813, 5754.510866576305, 5757.712114394263, 5762.423757624204, 5336.839894803162, 5496.395396506381, 5498.1752737088955, 5505.724713764296, 5513.145462453326, 4872.3909511311085, 4893.339399181065, 4897.657163998557, 4904.681195722266, 4912.361393018885, 5861.384554621789, 5872.0, 5879.323877754027, 5883.735231914574, 5937.198478205387, 5561.054620714407, 5677.602567820213, 5701.087825947994, 5711.257536520392, 5716.685582293014, 5868.031774757117, 5897.941020589739, 5927.525797936241, 5933.792317268875, 5973.104034394702, 5609.270794796814, 5616.6068375213345, 5627.18405831144, 5652.830415087554, 5654.971725141348, 5530.308711411074, 5696.487316141567, 5738.139279108167, 5754.367019627922, 5757.913631295618, 5536.750846211849, 5540.473655002768, 5589.217509548747, 5618.129189975561, 5650.576206784425, 5563.610547261653, 5570.972145139248, 5575.498205161555, 5582.8325150245555, 5585.69278689676, 5352.384475785178, 5487.094629386106, 5496.835094947158, 5513.917291240715, 5565.081761509306, 5513.145462453326, 5639.492445679908, 5658.773649053992, 5661.971690141523, 5686.971565142313, 5494.560435165097, 5504.4770746778995, 5505.311836020497, 5555.138953462219, 5555.333359996826], "value": 5238.302423830887, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.0167469488606, 588.5879884081143, 608.0544752909226, 621.0963048764049, 649.7628365646541, 39797.40303895444, 40697.59302406975, 44058.779706101464, 44149.55850441503, 44264.0, 44466.0, 45281.0, 45424.54575454244, 45606.54393456064, 45634.7718261409, 8777.34169937254, 9022.413543119676, 9025.729228123168, 9025.909740902573, 9033.593488293043, 8923.553822308892, 8969.327300452493, 9050.5022223778, 9050.637974481013, 9052.41159324645, 8982.910170898305, 9017.639294428214, 9098.63605455781, 9099.681511147111, 9104.8634270486, 9015.233705135071, 9056.049114842912, 9067.909320906772, 9072.22886054683, 9088.50013249271, 8852.557372131432, 8872.11278872114, 8884.422512536665, 8911.331650126202, 8931.347700675331, 42809.1438171238, 43302.35046474305, 43326.35010474845, 43330.56669433297, 43362.181458205116, 3511.10466830959, 3589.856405743767, 3611.855525778966, 3772.9056773580605, 4464.1071785643, 33446.331073378395, 33686.49470257948, 33758.83120584406, 34033.48949765755, 34252.82873585641, 3926.2736393767245, 3965.8215380307665, 3967.504061992251, 4028.798560071985, 4168.7081904266715, 357486.0, 358615.0, 358671.0, 359116.0, 360334.0, 58566.0, 58721.119183212286, 59191.0, 59357.0, 59582.0, 62653.68673156696, 63104.68447657732, 63113.0, 63123.36876631175, 63278.0, 15746.0, 15996.280167392495, 16192.595185120466, 16676.74984875228, 16828.57928551796, 12210.511579536897, 12234.632961011184, 12322.199057061262, 12326.260424374566, 12329.753404931851, 19854.50363740918, 19879.304224352367, 20077.59844803125, 20112.39662810118, 20230.69653955192, 7125.1168113378335, 7429.331360177502, 7438.5536867788105, 7581.801277629536, 7611.238876112345, 995.586831464934, 1098.8901109888948, 1149.0749946293315, 1185.6443067079842, 1213.8179273108929, 33688.663113369046, 33981.15047123842, 34300.48549271763, 34436.48345274823, 34500.854768815014, 1088.6570730219955, 1111.6887271563976, 1167.048855183023, 1178.4402408855724, 1218.561317925546, 17583.91208043977, 17736.467905962585, 18000.0, 18061.0, 18130.0, 590137.0, 591181.0, 592792.0, 593857.0, 598698.0, 40941.59058409378, 41054.58945410568, 41364.37953430701, 41452.37821432681, 60010.0, 1342.2684636872928, 1360.6054244269249, 1364.570160399471, 1367.2343487646751, 1378.2626294932163, 31951.0, 32888.0, 33560.0, 33659.26458330229, 34013.82993085019, 52536.21195682144, 52629.0, 52775.73612131915, 52777.208341875674, 52820.0, 465246.0, 465580.0, 466969.0, 467343.6632816814, 469794.0, 27849.860750696116, 29540.113796586138, 29848.0, 30085.247868803453, 30089.849550752107, 48897.0, 49766.25350619816, 49820.25269620886, 51967.74016130046, 53899.46100538944, 40597.1880562393, 42534.57465425306, 42689.0, 43716.12567748691, 44973.55026449694, 42430.57569424266, 43467.0, 43678.56321436872, 44252.612448887434, 44982.55017449784, 37061.44407833939, 43026.569734302255, 43054.0, 43419.131617368104, 44252.55747442613, 35817.283654326246, 37713.0, 38703.41944870885, 38989.610103898594, 39467.80266098651, 29149.7085029147, 29284.707152928197, 29544.261393465335, 29604.0, 30107.247318817204], "value": 20590.420934586822, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.9816259878838, 383.7639851491333, 385.06045249590994, 386.79113278829436, 401.50815251317124, 16290.918545407287, 17718.73421898671, 19023.0, 20586.588268234627, 20848.583028339443, 18505.907470462662, 19403.12685929133, 19710.21159153632, 19778.901105494453, 19888.0, 5507.669539827603, 5701.6864072476, 5850.0932355484965, 5860.531157507389, 5862.589618726691, 5378.704171270579, 5628.155776633497, 5731.226284451587, 5758.596898217126, 5767.077267637179, 5662.745176467049, 5701.74342154602, 5712.428757124296, 5713.028785106542, 5714.685692286923, 5452.754626041838, 5698.886022279573, 5704.515116215127, 5811.6803575803315, 5830.941690583082, 5526.281583394133, 5625.943740562624, 5641.576881733887, 5651.8587035324035, 5736.483716465538, 13867.306634668226, 14146.151230926074, 19675.40973770789, 24073.27780166598, 24165.275041748777, 2229.9219527316627, 2244.147224054865, 2530.962035569468, 2588.1717850287914, 2876.2090425133047, 9841.55712992917, 9858.16205622523, 9915.0, 10017.449040302781, 10029.548670309854, 1875.317280989012, 1882.6234753049446, 1923.413358925527, 1988.6321030609383, 2045.2841505473114, 80168.0, 81198.18801812024, 82322.17677823205, 82433.58783206105, 83216.58391708003, 10874.401907894984, 11059.834102488468, 11477.71305717347, 11623.476943537393, 11738.647840564796, 12101.636950891487, 15473.613159671098, 15568.455104071303, 15589.064656120443, 30127.397452050835, 8727.825443491094, 8873.378863479495, 9159.90840091604, 9697.224222062217, 9905.455199963926, 7791.92208077912, 7890.7632771015815, 7980.600969951479, 8197.098319184885, 8288.96387951506, 8815.338849586178, 8886.777830554158, 9023.774405639911, 9087.81824363509, 9186.311026673025, 3179.856906439216, 3477.791332520057, 3695.630436956337, 3768.8304026318883, 3784.0918179637238, 932.5477143585356, 964.2671569607149, 974.2644303550916, 1076.3703233608271, 1117.3240189685123, 20412.59174816525, 20434.489137771376, 21059.78940210609, 21187.77057624979, 21236.25673101434, 995.9004099590128, 1012.8075665623508, 1027.3938376357985, 1040.9895901041043, 1066.648006157966, 9345.345825792265, 10861.555795970778, 11079.833802492969, 11483.196176267582, 11502.0, 524518.1322280169, 529923.0, 531559.0, 542917.0, 546000.0, 86239.56880215558, 102528.48735756273, 106935.0, 107319.4634026825, 109894.0, 1006.7030226083323, 1007.6876168387677, 1048.9527971241312, 1053.7629033467563, 1054.1356088007913, 17095.91452042732, 17866.660000500273, 17976.730349044512, 18139.911605303725, 18224.908875455538, 43621.781891090344, 43876.56123438852, 43927.78036109799, 44089.0, 44130.11739765251, 56657.71671141618, 61517.69241153944, 62308.376916230256, 62469.37530624636, 62634.0, 8187.222213889671, 8291.58542072882, 8376.790580235544, 8450.154984501747, 8460.576971151295, 12476.688082798002, 13913.443462261801, 14061.648458788612, 14167.929160354131, 14358.282085895873, 11330.37682927447, 11559.653210403701, 11582.768344633228, 11842.348670823187, 12170.75658486843, 11640.343613125848, 11744.647660570197, 11771.0, 12081.093917956365, 12184.51261949512, 11528.769424611293, 11570.363630000431, 11587.478563464496, 11637.825432618687, 11942.0, 8218.096009438837, 8219.547924863951, 8230.588470576567, 8395.580220989048, 8824.91175088241, 8532.360072994674, 10926.672199834018, 12143.939280303543, 12168.2699038058, 12234.204776689487], "value": 9712.049808851847, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1498.325753410965, 1525.2678714217175, 1655.801303843538, 1750.8599312055037, 1802.9368972085972, 7865.095514015876, 8313.5011899286, 8656.394052416334, 8955.955220223897, 9023.278137748972, 8815.471071735701, 9096.818063638722, 9110.27117830572, 9143.542822858846, 9158.633654653806, 2381.4284571702797, 2429.8056155507516, 2437.6343548467694, 2439.4755127647554, 2447.7429869863677, 2374.347054560001, 2410.915617953372, 2454.0, 2455.5702752018415, 2465.5192237513693, 2393.617021276596, 2416.66166736657, 2420.068273714624, 2421.019487107724, 2441.4384691520872, 2302.574023805593, 2335.836491445591, 2342.390978345634, 2367.171489978511, 2407.1093695332665, 2325.1978067566833, 2339.263132113379, 2345.7419683834764, 2351.976480235193, 2386.2602593196166, 9150.176484116462, 9184.540772961325, 9198.310126740455, 9274.211692006187, 9287.814243715087, 5304.469553044703, 5404.432534583891, 5406.243125962368, 5412.648177868426, 5435.347758268994, 3443.2596991646915, 3466.2027733621157, 3493.8777142800136, 3503.544539209912, 3521.418965870628, 1160.2052593973156, 1166.7724793665238, 1182.4619797991893, 1189.6014835030276, 2120.639491286485, 12220.205686630341, 12583.937080314632, 12603.1807932485, 12626.873731262662, 12662.81005784914, 4475.351074094238, 4682.695624784378, 4749.762511874393, 4877.3903262092235, 4912.606991440676, 9865.0, 9870.506474676238, 9879.259055570861, 9898.10917017472, 9943.950280248697, 5504.119340905436, 5513.0, 5514.91727624086, 5517.282753242133, 5518.392976772552, 4376.584224498668, 4872.1473742094995, 5001.324821149098, 5077.162268225775, 5085.186370180753, 3880.767153970771, 4033.757974521538, 4048.5344185418467, 4049.6760259179196, 4084.0, 1342.9932850335686, 1360.6054244269249, 1370.787527933172, 1379.6275005748591, 1384.7507448659337, 812.273015650989, 901.8151278987792, 933.5239028095721, 944.6646440513656, 945.7682867697458, 5703.315602127771, 5826.329972053183, 5868.94131058684, 5908.947849588626, 6050.969745151334, 943.6791490893129, 972.5769290358575, 979.4025644356936, 983.0808194338316, 1029.7580068683853, 3874.108954940323, 3909.5308562972627, 3909.706771992112, 3999.8200080996426, 4020.19596080785, 11091.44542772858, 11498.195126341076, 11536.5002549668, 11560.94219528897, 11619.477123529461, 11476.0, 11519.88480115205, 11538.826917596243, 11586.246893951866, 11588.304701717923, 8055.597220139087, 8153.79615509617, 8373.874391884005, 8446.028706698808, 8472.195141461429, 5675.375708672125, 5690.203371528072, 5718.1708652246025, 5810.738516766671, 5945.791897283574, 10176.796464070825, 10350.430726309824, 10418.270721049454, 10434.0, 10468.319559228627, 9937.65218217359, 10326.380417174994, 10357.119644830274, 10495.632652857113, 10748.892511075102, 7127.536710113826, 7871.094824095073, 8047.235512626291, 8067.757967260992, 8166.510009399455, 8981.910180898107, 9023.639054437748, 9049.728508144766, 9069.0, 9080.137386948229, 7510.211427800221, 7519.812004699927, 7671.309582137635, 7739.651715672921, 7961.840763184588, 7506.24937506245, 7561.621918903923, 7618.162002179645, 7686.846263074819, 7809.687612495663, 6831.487638427038, 6908.032875397348, 6912.758053468105, 6924.238333783381, 6925.653717314013, 4859.586935110555, 5013.498650134958, 5044.621653375938, 5086.847394578169, 5111.974440127776, 4828.806847726192, 4889.437714662859, 4963.627727920348, 5002.449730529712, 5017.974910125426], "value": 4737.198736056559, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.58603150973823, 323.3000553801021, 330.37229264397655, 331.2943430493049, 335.8387973772589, 5340.225667278242, 5453.945460545393, 5555.472230138135, 5674.177244299579, 5694.487496125348, 5488.353493951809, 5516.91724624131, 5520.254765606642, 5520.365158006831, 5573.498385145336, 4307.50463696675, 4321.719088259253, 4324.589164029412, 4332.913341733163, 4347.869563913087, 4029.717919745619, 4260.275753121961, 4274.850380236692, 4340.131973605276, 4356.520782713899, 4221.387898754679, 4222.493300803892, 4238.406623072772, 4248.468941382327, 4249.150169966004, 4201.957980420188, 4219.346001369792, 4235.195312890556, 4277.8288868445225, 4291.54938731435, 3526.365254254233, 3736.084659258499, 3744.2885851688093, 3747.2880152770886, 3780.6786423154067, 5304.469553044703, 5381.327334083239, 5386.0, 5400.756965936543, 5431.158170483582, 4900.142475066885, 4900.950990490085, 4920.4833492483485, 4929.507049295078, 4937.0, 5449.591280653927, 5723.856903577403, 5728.140778883159, 5767.846430713874, 5775.422457754233, 4070.61329173728, 4081.571434999342, 4082.346824508094, 4124.298869192215, 4127.8968025799295, 6058.575899687024, 6061.54538409621, 6084.361142080063, 6092.634441933498, 6112.694365281763, 4105.938410923838, 4138.5654506276405, 4202.495700515897, 4203.201391735561, 4223.345381465878, 4195.0, 4225.549181474737, 4228.23891699497, 4234.428352172417, 4256.510501292391, 4890.975545122252, 4891.192953162688, 4895.0, 4907.386576677915, 4909.165441874889, 5557.194206840067, 5810.709464526757, 5843.824685259449, 5906.763729450774, 5922.548975500944, 1502.3239542206052, 1516.4768154986511, 1518.3850540530882, 1519.6352875310067, 1522.87055600273, 954.6754103604808, 966.4587830814767, 992.667456402099, 1002.644061358222, 1002.8367094170727, 4974.452810190876, 5023.6985780853265, 5029.597632189416, 5039.269305950616, 5073.898522029539, 5241.9737901310245, 5285.867853303698, 5297.761600727977, 5327.840164795062, 5386.676799392049, 4993.650444468925, 5057.595392368602, 5092.388913330424, 5275.920861187085, 5677.716114194356, 3176.920576985594, 3208.6684026128896, 3221.0, 3222.8871989480253, 3265.706086452231, 6170.845728856725, 6345.746170153235, 6363.809085727436, 6366.267879193952, 6379.330170332141, 6117.847053823601, 6126.295476020315, 6139.785107521305, 6163.599366041193, 6176.289726681399, 6282.811515654537, 6284.43440090385, 6307.810765677037, 6314.589551679126, 6329.841753956096, 5773.950247662187, 5962.2709414269375, 5998.610090344114, 6003.6397816131175, 6023.819285421444, 5979.701014949148, 5993.940060599338, 6017.669028203316, 6028.739222791453, 6040.335563087969, 6004.849878753066, 6222.782202622887, 6304.148939893055, 6308.779192728416, 6323.747050117944, 4082.4488694025927, 4156.397322388298, 4196.580341965779, 4209.6000879916355, 4217.662586993095, 6011.428914253139, 6024.3674414187635, 6046.183765191643, 6061.454469097803, 6068.241469816273, 5784.82645520635, 5808.361080281081, 5899.646021238739, 5942.286925568959, 5944.970275148597, 5760.308762948305, 5818.196359128684, 5820.534357251495, 5851.853703657443, 5898.292204935436, 5814.622049566934, 5822.301323841166, 5827.3881242470625, 5840.2115714379715, 5850.94149058504, 5585.860353491195, 5882.7058647066615, 5905.35041145465, 5914.083317085859, 5939.0, 5802.564807639528, 5829.842958105528, 5843.853903652443, 5855.209546711139, 5870.735816888165], "value": 4400.068676363697, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.9935000649994, 672.0960308385223, 677.6307654259921, 724.2106104346261, 760.2663429790251, 15604.84395156048, 15621.297041633125, 15910.124943128123, 15991.760123598155, 16994.405195818148, 15487.225638718048, 15896.52310430686, 15945.521634350987, 15945.601359965978, 15951.52145435636, 813.5200231863184, 835.2774849754949, 835.6532039203723, 837.6272558711375, 838.6645341863242, 671.2079745899837, 800.2557621412085, 823.9011318641772, 833.7415401225609, 834.486790623765, 850.7405241401401, 855.0423525651279, 855.3713020929642, 858.3133493205441, 858.8282343531288, 850.6597361055597, 852.1180578101666, 853.0829358439702, 853.7609469348592, 853.9829203415959, 620.6431302001367, 623.0996210475864, 624.4629618528062, 625.1560393468826, 625.6871564217892, 14334.42662293507, 14367.712645747131, 14380.64048398788, 14427.0, 14433.278336083154, 15180.924095379452, 15277.159756213403, 15296.0, 15393.23033848303, 15562.221888905622, 12441.377931103409, 12525.0, 12550.74898502025, 12588.559400421032, 12610.432530536147, 3893.415987601854, 3929.4105884117325, 4030.375291829771, 4034.406409468273, 4109.404136400235, 83310.58344708238, 84978.0, 85048.14951850464, 85402.57298713467, 85917.57041214754, 11821.940890295493, 11957.880421195676, 12013.399330033639, 12136.393180340947, 12755.744885102245, 20850.47873803137, 21037.158513659284, 21049.473763156042, 21111.472213194793, 21385.0, 8859.911400885909, 8860.601272942604, 8977.50623715689, 8986.775330616656, 9197.0, 4771.73755443454, 4862.3922009748785, 4867.9269810952865, 4930.784179526525, 5000.199968005175, 3360.2103505676146, 3429.091290807938, 3449.862005519801, 3464.8614055438006, 3475.3223121491574, 481.14278883509627, 581.2443823030044, 588.1824264272665, 588.6203398807745, 590.7991282963727, 641.7336805225872, 708.1431467923767, 716.2801384608539, 723.5260904107818, 746.4998451037818, 9407.0, 9829.705108846745, 10145.442000689885, 10191.898081019242, 10219.7445063874, 542.4223202289548, 632.8797528469576, 699.6606645776794, 710.36422401951, 723.3020135569201, 4510.864674059783, 4512.435945506812, 4568.817247310137, 4576.427946506687, 4643.094596553639, 110992.0, 117984.0, 118717.0, 119723.0, 122140.0, 98462.50768746111, 99822.0, 99895.0, 101126.0, 102825.48587257016, 88681.0, 89567.55216223878, 89996.0, 90809.0, 93510.53244733733, 8391.538465384463, 8633.179847914438, 8704.956475217583, 8709.390342676204, 8741.519216443157, 50599.49400505948, 50966.490335096176, 51059.2341114891, 51063.489365105874, 52609.47390526199, 66451.66774166099, 79630.0, 82020.0, 82598.0, 82901.58549207215, 11737.119716021503, 11821.468033938665, 11860.22908510944, 11969.0, 12011.63965081049, 14055.0, 14139.64650883736, 14188.21964791905, 14245.786313205517, 14256.572302830931, 12727.236365817711, 13550.796738049134, 13668.589942301747, 13704.862951370758, 13983.860161398256, 12296.20074695142, 12404.25574465535, 12421.254724716546, 12537.0, 12866.421011054712, 11755.823662644896, 11993.34036627959, 12115.15193936416, 12131.878681213075, 12931.870681293067, 9808.754781130528, 10043.461122005661, 10075.244356673133, 10205.081542661195, 10491.160707143563, 8254.83490330202, 8617.48295102296, 8861.0, 9046.803084341202, 9389.671361502315], "value": 7467.426621354036, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 107.0, 111.0, 115.0, 112.0, 114.0, 111.0, 112.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 117.0, 146.0, 181.0, 118.0, 159.0, 152.0, 125.0, 182.0, 128.0], "value": 146.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 163.0, 162.0, 166.0, 168.0, 162.0, 162.0, 161.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 76.0, 175.0, 78.0, 77.0, 75.0, 77.0, 172.0, 76.0], "value": 96.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 175.0, 85.0, 85.0, 85.0, 140.0, 86.0, 84.0, 138.0], "value": 104.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 147.0, 148.0, 149.0, 148.0, 146.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 99.0, 100.0, 95.0, 96.0, 95.0, 95.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 52.0, 53.0, 52.0, 54.0, 51.0, 53.0, 56.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 59.0, 60.0, 59.0, 60.0, 59.0, 61.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 77.0, 78.0, 77.0, 85.0, 78.0, 76.0, 82.0, 78.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 137.0, 138.0, 135.0, 130.0, 125.0, 134.0, 126.0, 138.0], "value": 133.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 173.0, 168.0, 168.0, 166.0, 168.0, 171.0, 167.0, 168.0, 170.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 64.0, 65.0, 64.0, 68.0, 66.0, 63.0, 66.0, 64.0], "value": 65.5, "unit": "score"}]}]} 10:51:38 INFO - Return code: 0 10:51:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:51:38 ERROR - # TBPL SUCCESS # 10:51:38 INFO - Running post-action listener: _resource_record_post_action 10:51:38 INFO - [mozharness: 2016-08-04 17:51:38.955551Z] Finished run-tests step (success) 10:51:38 INFO - Running post-run listener: _resource_record_post_run 10:51:39 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 558858240; Read time: 108; Write time: 486836 10:51:39 INFO - TinderboxPrint: CPU usage
13.3% 10:51:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 108 10:51:39 INFO - TinderboxPrint: I/O write bytes / time
558,858,240 / 486,836 10:51:39 INFO - TinderboxPrint: CPU idle
8,237.5 (86.7%) 10:51:39 INFO - TinderboxPrint: CPU user
1,209.1 (12.7%) 10:51:39 INFO - TinderboxPrint: Swap in / out
0 / 0 10:51:39 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 265334784; Read time: 0; Write time: 278444 10:51:39 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292986880; Read time: 108; Write time: 208304 10:51:39 INFO - Running post-run listener: _upload_blobber_files 10:51:39 INFO - Blob upload gear active. 10:51:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:51:39 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:51:39 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:51:39 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:51:39 INFO - (blobuploader) - INFO - Open directory for files ... 10:51:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:51:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:51:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:40 INFO - (blobuploader) - INFO - Done attempting. 10:51:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:51:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:51:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:44 INFO - (blobuploader) - INFO - Done attempting. 10:51:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:51:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:51:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:45 INFO - (blobuploader) - INFO - Done attempting. 10:51:45 INFO - (blobuploader) - INFO - Iteration through files over. 10:51:45 INFO - Return code: 0 10:51:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:51:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:51:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c3a63386a92674269853ab4f60d7845f904f1ea9fb3390c37a77e7884f762d7ab31eecdbc11619406d3febad301995e0b310fd656e1946a77e6952549876cdfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3e2977d01524089a3d7a8325bc5f81c537804f83eb3bb9e36cf4b9c6d2ee986e8899dff8f8d15e0fcf63b34e31c202b6f0625f762e6f57f075d7db3d06375c9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6b32c65ca1d4a54c9e4d95c7a1d37375fc52bb0f383043834b770554b91e73c86e0138cf6f7f9634f9fa6c82c48a088c2a6caf1e749ab4609299d75d73964bfa"} 10:51:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:51:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:51:45 INFO - Contents: 10:51:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c3a63386a92674269853ab4f60d7845f904f1ea9fb3390c37a77e7884f762d7ab31eecdbc11619406d3febad301995e0b310fd656e1946a77e6952549876cdfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3e2977d01524089a3d7a8325bc5f81c537804f83eb3bb9e36cf4b9c6d2ee986e8899dff8f8d15e0fcf63b34e31c202b6f0625f762e6f57f075d7db3d06375c9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6b32c65ca1d4a54c9e4d95c7a1d37375fc52bb0f383043834b770554b91e73c86e0138cf6f7f9634f9fa6c82c48a088c2a6caf1e749ab4609299d75d73964bfa"} 10:51:45 INFO - Running post-run listener: copy_logs_to_upload_dir 10:51:45 INFO - Copying logs to upload dir... 10:51:45 INFO - mkdir: /builds/slave/test/build/upload/logs 10:51:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.775818 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-08-04 10:51:44.206855) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 10:51:44.210742) ========= 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=6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c3a63386a92674269853ab4f60d7845f904f1ea9fb3390c37a77e7884f762d7ab31eecdbc11619406d3febad301995e0b310fd656e1946a77e6952549876cdfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3e2977d01524089a3d7a8325bc5f81c537804f83eb3bb9e36cf4b9c6d2ee986e8899dff8f8d15e0fcf63b34e31c202b6f0625f762e6f57f075d7db3d06375c9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6b32c65ca1d4a54c9e4d95c7a1d37375fc52bb0f383043834b770554b91e73c86e0138cf6f7f9634f9fa6c82c48a088c2a6caf1e749ab4609299d75d73964bfa"} build_url:https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c3a63386a92674269853ab4f60d7845f904f1ea9fb3390c37a77e7884f762d7ab31eecdbc11619406d3febad301995e0b310fd656e1946a77e6952549876cdfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3e2977d01524089a3d7a8325bc5f81c537804f83eb3bb9e36cf4b9c6d2ee986e8899dff8f8d15e0fcf63b34e31c202b6f0625f762e6f57f075d7db3d06375c9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6b32c65ca1d4a54c9e4d95c7a1d37375fc52bb0f383043834b770554b91e73c86e0138cf6f7f9634f9fa6c82c48a088c2a6caf1e749ab4609299d75d73964bfa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 10:51:44.241353) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:51:44.241815) ========= 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=6dbc10da6d83fee962c624be000001a8-1470329865.725025-407359956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:51:44.326704) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 10:51:44.327106) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 10:51:44.327494) ========= ========= Total master_lag: 0.19 =========