builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-065 starttime: 1471350444.86 results: success (0) buildid: 20160816015422 builduid: 41fd77f97f8f46278de029989f34daca revision: 1a4509a3e2ce583753eda01ba911b34631bf207e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 05:27:24.859001) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 05:27:24.859964) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 05:27:24.860667) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 05:27:24.887766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:27:24.888064) ========= 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=523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-16 05:27:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 64.1M=0s 2016-08-16 05:27:25 (64.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125080 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:27:25.027274) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:27:25.027607) ========= 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=523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019524 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:27:25.076962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 05:27:25.077328) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1a4509a3e2ce583753eda01ba911b34631bf207e --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 1a4509a3e2ce583753eda01ba911b34631bf207e --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=523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-16 05:27:26,088 truncating revision to first 12 chars 2016-08-16 05:27:26,088 Setting DEBUG logging. 2016-08-16 05:27:26,088 attempt 1/10 2016-08-16 05:27:26,088 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/1a4509a3e2ce?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 05:27:27,368 unpacking tar archive at: mozilla-inbound-1a4509a3e2ce/testing/mozharness/ program finished with exit code 0 elapsedTime=1.612269 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 05:27:26.707686) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 05:27:26.708503) ========= script_repo_revision: 1a4509a3e2ce583753eda01ba911b34631bf207e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 05:27:26.709471) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 05:27:26.710178) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 05:27:26.721698) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-08-16 05:27:26.722110) ========= /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=523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:27:27 INFO - MultiFileLogger online at 20160816 05:27:27 in /builds/slave/test 05:27:27 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 05:27:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:27:27 INFO - {'append_to_log': False, 05:27:27 INFO - 'base_work_dir': '/builds/slave/test', 05:27:27 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 05:27:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:27:27 INFO - 'branch': 'Mozilla-Inbound', 05:27:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:27:27 INFO - 'config_files': ('talos/linux_config.py',), 05:27:27 INFO - 'default_actions': ('clobber', 05:27:27 INFO - 'read-buildbot-config', 05:27:27 INFO - 'download-and-extract', 05:27:27 INFO - 'populate-webroot', 05:27:27 INFO - 'create-virtualenv', 05:27:27 INFO - 'install', 05:27:27 INFO - 'run-tests'), 05:27:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:27:27 INFO - 'download_minidump_stackwalk': True, 05:27:27 INFO - 'download_symbols': 'ondemand', 05:27:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:27:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:27:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:27:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:27:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:27:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:27:27 INFO - 'installer_path': 'installer.exe', 05:27:27 INFO - 'log_level': 'info', 05:27:27 INFO - 'log_name': 'talos', 05:27:27 INFO - 'log_to_console': True, 05:27:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:27:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:27:27 INFO - 'opt_config_files': (), 05:27:27 INFO - 'pip_index': False, 05:27:27 INFO - 'sps_profile': False, 05:27:27 INFO - 'sps_profile_interval': 0, 05:27:27 INFO - 'suite': 'dromaeojs-e10s', 05:27:27 INFO - 'system_bits': '32', 05:27:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:27:27 INFO - 'title': 'talos-linux64-ix-065', 05:27:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:27:27 INFO - 'use_talos_json': True, 05:27:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:27:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:27:27 INFO - 'work_dir': 'build'} 05:27:27 INFO - [mozharness: 2016-08-16 12:27:27.830137Z] Running clobber step. 05:27:27 INFO - Running pre-action listener: _resource_record_pre_action 05:27:27 INFO - Running main action method: clobber 05:27:27 INFO - rmtree: /builds/slave/test/build 05:27:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:27:28 INFO - Running post-action listener: _resource_record_post_action 05:27:28 INFO - [mozharness: 2016-08-16 12:27:28.291626Z] Finished clobber step (success) 05:27:28 INFO - [mozharness: 2016-08-16 12:27:28.291729Z] Running read-buildbot-config step. 05:27:28 INFO - Running pre-action listener: _resource_record_pre_action 05:27:28 INFO - Running main action method: read_buildbot_config 05:27:28 INFO - Using buildbot properties: 05:27:28 INFO - { 05:27:28 INFO - "project": "", 05:27:28 INFO - "product": "firefox", 05:27:28 INFO - "script_repo_revision": "production", 05:27:28 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 05:27:28 INFO - "repository": "", 05:27:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 05:27:28 INFO - "buildid": "20160816015422", 05:27:28 INFO - "pgo_build": "True", 05:27:28 INFO - "basedir": "/builds/slave/test", 05:27:28 INFO - "buildnumber": 1207, 05:27:28 INFO - "slavename": "talos-linux64-ix-065", 05:27:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:27:28 INFO - "platform": "ubuntu64_hw", 05:27:28 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 05:27:28 INFO - "branch": "mozilla-inbound", 05:27:28 INFO - "repo_path": "integration/mozilla-inbound", 05:27:28 INFO - "revision": "1a4509a3e2ce583753eda01ba911b34631bf207e", 05:27:28 INFO - "stage_platform": "linux64-pgo", 05:27:28 INFO - "builduid": "41fd77f97f8f46278de029989f34daca", 05:27:28 INFO - "slavebuilddir": "test" 05:27:28 INFO - } 05:27:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:27:28 INFO - Running post-action listener: _resource_record_post_action 05:27:28 INFO - [mozharness: 2016-08-16 12:27:28.294191Z] Finished read-buildbot-config step (success) 05:27:28 INFO - [mozharness: 2016-08-16 12:27:28.294280Z] Running download-and-extract step. 05:27:28 INFO - Running pre-action listener: _resource_record_pre_action 05:27:28 INFO - Running main action method: download_and_extract 05:27:28 INFO - mkdir: /builds/slave/test/build/tests 05:27: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')]} 05:27:28 INFO - trying https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:27:28 INFO - Downloading https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/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 05:27:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/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 05:27:28 INFO - Downloaded 1361 bytes. 05:27:28 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:27:28 INFO - Using the following test package requirements: 05:27:28 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:27:28 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:27:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:27:28 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:27:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:27:28 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:27:28 INFO - u'jsshell-linux-x86_64.zip'], 05:27:28 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:27:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:27:28 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:27:28 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:27:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:27:28 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:27:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:27:28 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:27:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:27:28 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:27:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:27:28 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:27: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')]} 05:27:28 INFO - trying https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:27:28 INFO - Downloading https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/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 05:27:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/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 05:27:29 INFO - Downloaded 21833862 bytes. 05:27:29 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'] 05:27:29 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 05:27:30 INFO - Return code: 0 05:27:30 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 05:27:30 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')]} 05:27:30 INFO - trying https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:27:30 INFO - Downloading https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/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 05:27:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/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 05:27:31 INFO - Downloaded 21833862 bytes. 05:27:31 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'] 05:27:31 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 05:27:32 INFO - Return code: 0 05:27:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:32 INFO - trying https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:27:32 INFO - Downloading https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/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 05:27:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/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 05:27:33 INFO - Downloaded 14413719 bytes. 05:27:33 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'] 05:27:33 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 05:27:33 INFO - Return code: 0 05:27: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')]} 05:27:33 INFO - trying https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:27:33 INFO - Downloading https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/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 05:27:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/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 05:27:35 INFO - Downloaded 59343017 bytes. 05:27:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:27:35 INFO - mkdir: /builds/slave/test/properties 05:27:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:27:35 INFO - Writing to file /builds/slave/test/properties/build_url 05:27:35 INFO - Contents: 05:27:35 INFO - build_url:https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:27:36 INFO - Running post-action listener: _resource_record_post_action 05:27:36 INFO - Running post-action listener: set_extra_try_arguments 05:27:36 INFO - [mozharness: 2016-08-16 12:27:36.020046Z] Finished download-and-extract step (success) 05:27:36 INFO - [mozharness: 2016-08-16 12:27:36.020280Z] Running populate-webroot step. 05:27:36 INFO - Running pre-action listener: _resource_record_pre_action 05:27:36 INFO - Running main action method: populate_webroot 05:27:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:27:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:27:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:27:36 INFO - '--tppagecycles', 05:27:36 INFO - '7'], 05:27:36 INFO - 'tests': ['tsvgm']}}, 05:27:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:27:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:27:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:27:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:27:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:27:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:27:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:36 INFO - 'talos_options': ['--disable-e10s'], 05:27:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:36 INFO - 'talos_options': ['--disable-e10s'], 05:27:36 INFO - 'tests': ['damp', 'tps']}, 05:27:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:36 INFO - 'tests': ['damp', 'tps']}, 05:27:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:27:36 INFO - 'tests': ['dromaeo_dom']}, 05:27:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:27:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:27:36 INFO - 'tests': ['basic_compositor_video']}, 05:27:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:27:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:27:36 INFO - 'tests': ['a11yr', 05:27:36 INFO - 'ts_paint', 05:27:36 INFO - 'tpaint', 05:27:36 INFO - 'sessionrestore', 05:27:36 INFO - 'sessionrestore_no_auto_restore', 05:27:36 INFO - 'tabpaint']}, 05:27:36 INFO - 'other-e10s': {'tests': ['a11yr', 05:27:36 INFO - 'ts_paint', 05:27:36 INFO - 'tpaint', 05:27:36 INFO - 'sessionrestore', 05:27:36 INFO - 'sessionrestore_no_auto_restore', 05:27:36 INFO - 'tabpaint']}, 05:27:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:27:36 INFO - 'ts_paint', 05:27:36 INFO - 'tpaint', 05:27:36 INFO - 'sessionrestore', 05:27:36 INFO - 'sessionrestore_no_auto_restore', 05:27:36 INFO - 'tabpaint']}, 05:27:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:27:36 INFO - 'ts_paint', 05:27:36 INFO - 'tpaint', 05:27:36 INFO - 'sessionrestore', 05:27:36 INFO - 'sessionrestore_no_auto_restore', 05:27:36 INFO - 'tabpaint']}, 05:27:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:27:36 INFO - 'tests': ['a11yr', 05:27:36 INFO - 'ts_paint', 05:27:36 INFO - 'tpaint', 05:27:36 INFO - 'sessionrestore', 05:27:36 INFO - 'sessionrestore_no_auto_restore', 05:27:36 INFO - 'tabpaint']}, 05:27:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:27:36 INFO - 'tests': ['a11yr', 05:27:36 INFO - 'ts_paint', 05:27:36 INFO - 'tpaint', 05:27:36 INFO - 'sessionrestore', 05:27:36 INFO - 'sessionrestore_no_auto_restore', 05:27:36 INFO - 'tabpaint']}, 05:27:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:27:36 INFO - 'tests': ['tsvgx', 05:27:36 INFO - 'tsvgr_opacity', 05:27:36 INFO - 'tart', 05:27:36 INFO - 'tscrollx', 05:27:36 INFO - 'cart']}, 05:27:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:27:36 INFO - 'tsvgr_opacity', 05:27:36 INFO - 'tart', 05:27:36 INFO - 'tscrollx', 05:27:36 INFO - 'cart']}, 05:27:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:36 INFO - 'talos_options': ['--disable-e10s'], 05:27:36 INFO - 'tests': ['tp5o']}, 05:27:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:36 INFO - 'tests': ['tp5o']}, 05:27:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:36 INFO - 'talos_options': ['--disable-e10s', 05:27:36 INFO - '--xperf_path', 05:27:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:36 INFO - 'tests': ['tp5n']}, 05:27:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:36 INFO - 'talos_options': ['--xperf_path', 05:27:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:36 INFO - 'tests': ['tp5n']}}, 05:27:36 INFO - 'talos.zip': {'path': '', 05:27:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:27:36 INFO - Running post-action listener: _resource_record_post_action 05:27:36 INFO - [mozharness: 2016-08-16 12:27:36.036994Z] Finished populate-webroot step (success) 05:27:36 INFO - [mozharness: 2016-08-16 12:27:36.037083Z] Running create-virtualenv step. 05:27:36 INFO - Running pre-action listener: _resource_record_pre_action 05:27:36 INFO - Running main action method: create_virtualenv 05:27:36 INFO - Creating virtualenv /builds/slave/test/build/venv 05:27:36 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 05:27:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:27:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:27:36 INFO - Using real prefix '/usr' 05:27:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:27:36 INFO - Installing distribute.............................................................................................................................................................................................done. 05:27:38 INFO - Installing pip.................done. 05:27:38 INFO - Return code: 0 05:27:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:27:38 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')]} 05:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:38 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')]} 05:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:38 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 0x1129030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1358400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e7570>, '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 0x13e8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e8900>, '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': '523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659', '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 05:27:38 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 05:27:38 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 05:27:38 INFO - Using env: {'DISPLAY': ':0', 05:27:38 INFO - 'HOME': '/home/cltbld', 05:27:38 INFO - 'LANG': 'en_US.UTF-8', 05:27:38 INFO - 'LANGUAGE': 'en_US:en', 05:27:38 INFO - 'LOGNAME': 'cltbld', 05:27:38 INFO - 'MAIL': '/var/mail/cltbld', 05:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:38 INFO - 'MOZ_NO_REMOTE': '1', 05:27:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:38 INFO - 'NO_EM_RESTART': '1', 05:27:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:38 INFO - 'PWD': '/builds/slave/test', 05:27:38 INFO - 'SHELL': '/bin/bash', 05:27:38 INFO - 'SHLVL': '1', 05:27:38 INFO - 'TERM': 'linux', 05:27:38 INFO - 'TMOUT': '86400', 05:27:38 INFO - 'USER': 'cltbld', 05:27:38 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659', 05:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:38 INFO - '_': '/tools/buildbot/bin/python'} 05:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:38 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 05:27:38 INFO - Cleaning up... 05:27:38 INFO - Return code: 0 05:27:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:27:38 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')]} 05:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:38 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')]} 05:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:38 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 0x1129030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1358400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e7570>, '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 0x13e8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e8900>, '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': '523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659', '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 05:27:38 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 05:27:38 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 05:27:38 INFO - Using env: {'DISPLAY': ':0', 05:27:38 INFO - 'HOME': '/home/cltbld', 05:27:38 INFO - 'LANG': 'en_US.UTF-8', 05:27:38 INFO - 'LANGUAGE': 'en_US:en', 05:27:38 INFO - 'LOGNAME': 'cltbld', 05:27:38 INFO - 'MAIL': '/var/mail/cltbld', 05:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:38 INFO - 'MOZ_NO_REMOTE': '1', 05:27:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:38 INFO - 'NO_EM_RESTART': '1', 05:27:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:38 INFO - 'PWD': '/builds/slave/test', 05:27:38 INFO - 'SHELL': '/bin/bash', 05:27:38 INFO - 'SHLVL': '1', 05:27:38 INFO - 'TERM': 'linux', 05:27:38 INFO - 'TMOUT': '86400', 05:27:38 INFO - 'USER': 'cltbld', 05:27:38 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659', 05:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:38 INFO - '_': '/tools/buildbot/bin/python'} 05:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:39 INFO - Downloading/unpacking psutil>=3.1.1 05:27: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 05:27: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 05:27: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 05:27: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 05:27: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 05:27: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 05:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:27:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:27:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:27:41 INFO - Installing collected packages: psutil 05:27:41 INFO - Running setup.py install for psutil 05:27:41 INFO - building 'psutil._psutil_linux' extension 05:27:41 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 05:27:41 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 05:27:41 INFO - building 'psutil._psutil_posix' extension 05:27:41 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 05:27:41 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 05:27:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:27:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:27:41 INFO - Successfully installed psutil 05:27:41 INFO - Cleaning up... 05:27:41 INFO - Return code: 0 05:27:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:27:41 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')]} 05:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:41 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')]} 05:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:41 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 0x1129030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1358400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e7570>, '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 0x13e8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e8900>, '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': '523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659', '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 05:27:41 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 05:27:41 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 05:27:41 INFO - Using env: {'DISPLAY': ':0', 05:27:41 INFO - 'HOME': '/home/cltbld', 05:27:41 INFO - 'LANG': 'en_US.UTF-8', 05:27:41 INFO - 'LANGUAGE': 'en_US:en', 05:27:41 INFO - 'LOGNAME': 'cltbld', 05:27:41 INFO - 'MAIL': '/var/mail/cltbld', 05:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:41 INFO - 'MOZ_NO_REMOTE': '1', 05:27:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:41 INFO - 'NO_EM_RESTART': '1', 05:27:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:41 INFO - 'PWD': '/builds/slave/test', 05:27:41 INFO - 'SHELL': '/bin/bash', 05:27:41 INFO - 'SHLVL': '1', 05:27:41 INFO - 'TERM': 'linux', 05:27:41 INFO - 'TMOUT': '86400', 05:27:41 INFO - 'USER': 'cltbld', 05:27:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659', 05:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:41 INFO - '_': '/tools/buildbot/bin/python'} 05:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:27:41 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 05:27:41 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 05:27:41 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 05:27:41 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 05:27:41 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 05:27:41 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 05:27:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:27:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:27:43 INFO - Installing collected packages: mozsystemmonitor 05:27:43 INFO - Running setup.py install for mozsystemmonitor 05:27:43 INFO - Successfully installed mozsystemmonitor 05:27:43 INFO - Cleaning up... 05:27:44 INFO - Return code: 0 05:27:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:27:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:44 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 0x1129030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1358400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e7570>, '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 0x13e8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e8900>, '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': '523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659', '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 05:27:44 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 05:27:44 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 05:27:44 INFO - Using env: {'DISPLAY': ':0', 05:27:44 INFO - 'HOME': '/home/cltbld', 05:27:44 INFO - 'LANG': 'en_US.UTF-8', 05:27:44 INFO - 'LANGUAGE': 'en_US:en', 05:27:44 INFO - 'LOGNAME': 'cltbld', 05:27:44 INFO - 'MAIL': '/var/mail/cltbld', 05:27:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:44 INFO - 'MOZ_NO_REMOTE': '1', 05:27:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:44 INFO - 'NO_EM_RESTART': '1', 05:27:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:44 INFO - 'PWD': '/builds/slave/test', 05:27:44 INFO - 'SHELL': '/bin/bash', 05:27:44 INFO - 'SHLVL': '1', 05:27:44 INFO - 'TERM': 'linux', 05:27:44 INFO - 'TMOUT': '86400', 05:27:44 INFO - 'USER': 'cltbld', 05:27:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659', 05:27:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:44 INFO - '_': '/tools/buildbot/bin/python'} 05:27:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:44 INFO - Downloading/unpacking jsonschema==2.5.1 05:27: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 05:27: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 05:27: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 05:27: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 05:27: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 05:27: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 05:27:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:27:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:46 INFO - Downloading functools32-3.2.3-2.tar.gz 05:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:27:46 INFO - warning: no files found matching '*.txt' 05:27:46 INFO - no previously-included directories found matching 'build' 05:27:46 INFO - no previously-included directories found matching 'dist' 05:27:46 INFO - no previously-included directories found matching '.git*' 05:27:46 INFO - Installing collected packages: jsonschema, functools32 05:27:46 INFO - Running setup.py install for functools32 05:27:46 INFO - warning: no files found matching '*.txt' 05:27:46 INFO - no previously-included directories found matching 'build' 05:27:46 INFO - no previously-included directories found matching 'dist' 05:27:46 INFO - no previously-included directories found matching '.git*' 05:27:46 INFO - Successfully installed jsonschema functools32 05:27:46 INFO - Cleaning up... 05:27:46 INFO - Return code: 0 05:27:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:27:46 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')]} 05:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:46 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')]} 05:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:46 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 0x1129030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1358400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e7570>, '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 0x13e8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e8900>, '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': '523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659', '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 05:27:46 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 05:27:46 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 05:27:46 INFO - Using env: {'DISPLAY': ':0', 05:27:46 INFO - 'HOME': '/home/cltbld', 05:27:46 INFO - 'LANG': 'en_US.UTF-8', 05:27:46 INFO - 'LANGUAGE': 'en_US:en', 05:27:46 INFO - 'LOGNAME': 'cltbld', 05:27:46 INFO - 'MAIL': '/var/mail/cltbld', 05:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:46 INFO - 'MOZ_NO_REMOTE': '1', 05:27:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:46 INFO - 'NO_EM_RESTART': '1', 05:27:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:46 INFO - 'PWD': '/builds/slave/test', 05:27:46 INFO - 'SHELL': '/bin/bash', 05:27:46 INFO - 'SHLVL': '1', 05:27:46 INFO - 'TERM': 'linux', 05:27:46 INFO - 'TMOUT': '86400', 05:27:46 INFO - 'USER': 'cltbld', 05:27:46 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659', 05:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:46 INFO - '_': '/tools/buildbot/bin/python'} 05:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:27:46 INFO - Cleaning up... 05:27:46 INFO - Return code: 0 05:27:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:27:46 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')]} 05:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:46 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')]} 05:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:46 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 0x1129030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1358400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e7570>, '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 0x13e8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e8900>, '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': '523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659', '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 05:27:46 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 05:27:46 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 05:27:46 INFO - Using env: {'DISPLAY': ':0', 05:27:46 INFO - 'HOME': '/home/cltbld', 05:27:46 INFO - 'LANG': 'en_US.UTF-8', 05:27:46 INFO - 'LANGUAGE': 'en_US:en', 05:27:46 INFO - 'LOGNAME': 'cltbld', 05:27:46 INFO - 'MAIL': '/var/mail/cltbld', 05:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:46 INFO - 'MOZ_NO_REMOTE': '1', 05:27:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:46 INFO - 'NO_EM_RESTART': '1', 05:27:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:46 INFO - 'PWD': '/builds/slave/test', 05:27:46 INFO - 'SHELL': '/bin/bash', 05:27:46 INFO - 'SHLVL': '1', 05:27:46 INFO - 'TERM': 'linux', 05:27:46 INFO - 'TMOUT': '86400', 05:27:46 INFO - 'USER': 'cltbld', 05:27:46 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659', 05:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:46 INFO - '_': '/tools/buildbot/bin/python'} 05:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:46 INFO - Downloading/unpacking blobuploader==1.2.4 05:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:48 INFO - Downloading blobuploader-1.2.4.tar.gz 05:27:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:27:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:27:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:27:49 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 05:27:49 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 05:27:49 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 05:27:49 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 05:27:49 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 05:27:49 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 05:27:49 INFO - Downloading docopt-0.6.1.tar.gz 05:27:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:27:49 INFO - Installing collected packages: blobuploader, requests, docopt 05:27:49 INFO - Running setup.py install for blobuploader 05:27:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:27:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:27:49 INFO - Running setup.py install for requests 05:27:50 INFO - Running setup.py install for docopt 05:27:50 INFO - Successfully installed blobuploader requests docopt 05:27:50 INFO - Cleaning up... 05:27:50 INFO - Return code: 0 05:27:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:50 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')]} 05:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:50 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')]} 05:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:50 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 0x1129030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1358400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e7570>, '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 0x13e8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e8900>, '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': '523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659', '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 05:27:50 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 05:27:50 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 05:27:50 INFO - Using env: {'DISPLAY': ':0', 05:27:50 INFO - 'HOME': '/home/cltbld', 05:27:50 INFO - 'LANG': 'en_US.UTF-8', 05:27:50 INFO - 'LANGUAGE': 'en_US:en', 05:27:50 INFO - 'LOGNAME': 'cltbld', 05:27:50 INFO - 'MAIL': '/var/mail/cltbld', 05:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:50 INFO - 'MOZ_NO_REMOTE': '1', 05:27:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:50 INFO - 'NO_EM_RESTART': '1', 05:27:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:50 INFO - 'PWD': '/builds/slave/test', 05:27:50 INFO - 'SHELL': '/bin/bash', 05:27:50 INFO - 'SHLVL': '1', 05:27:50 INFO - 'TERM': 'linux', 05:27:50 INFO - 'TMOUT': '86400', 05:27:50 INFO - 'USER': 'cltbld', 05:27:50 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659', 05:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:50 INFO - '_': '/tools/buildbot/bin/python'} 05:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:50 INFO - Running setup.py (path:/tmp/pip-1CjbV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:50 INFO - Running setup.py (path:/tmp/pip-8k_WZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:50 INFO - Running setup.py (path:/tmp/pip-Ddf6xY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:50 INFO - Running setup.py (path:/tmp/pip-C9KN8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:50 INFO - Running setup.py (path:/tmp/pip-4CTtVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:50 INFO - Running setup.py (path:/tmp/pip-7LmsN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:50 INFO - Running setup.py (path:/tmp/pip-rjKu8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:50 INFO - Running setup.py (path:/tmp/pip-6UpMpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:51 INFO - Running setup.py (path:/tmp/pip-wHb3p2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:51 INFO - Running setup.py (path:/tmp/pip-cjyNkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:51 INFO - Running setup.py (path:/tmp/pip-0lBiTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:51 INFO - Running setup.py (path:/tmp/pip-ZT2ua0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:51 INFO - Running setup.py (path:/tmp/pip-emaCaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:51 INFO - Running setup.py (path:/tmp/pip-fGwp_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:51 INFO - Running setup.py (path:/tmp/pip-ROFkA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:51 INFO - Running setup.py (path:/tmp/pip-j02RkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:51 INFO - Running setup.py (path:/tmp/pip-vOrhmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:27:51 INFO - Running setup.py install for manifestparser 05:27:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:27:51 INFO - Running setup.py install for mozcrash 05:27:51 INFO - Running setup.py install for mozdebug 05:27:51 INFO - Running setup.py install for mozdevice 05:27:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:27:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:27:52 INFO - Running setup.py install for mozfile 05:27:52 INFO - Running setup.py install for mozhttpd 05:27:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:27:52 INFO - Running setup.py install for mozinfo 05:27:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:27:52 INFO - Running setup.py install for mozInstall 05:27:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:27:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:27:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:27:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:27:52 INFO - Running setup.py install for mozleak 05:27:52 INFO - Running setup.py install for mozlog 05:27:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:27:52 INFO - Running setup.py install for moznetwork 05:27:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:27:52 INFO - Running setup.py install for mozprocess 05:27:52 INFO - Running setup.py install for mozprofile 05:27:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:27:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:27:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:27:53 INFO - Running setup.py install for mozrunner 05:27:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:27:53 INFO - Running setup.py install for mozscreenshot 05:27:53 INFO - Running setup.py install for moztest 05:27:53 INFO - Running setup.py install for mozversion 05:27:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:27:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:27:53 INFO - Cleaning up... 05:27:53 INFO - Return code: 0 05:27:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:53 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')]} 05:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:53 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')]} 05:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:53 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 0x1129030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1358400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e7570>, '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 0x13e8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e8900>, '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': '523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659', '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 05:27:53 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 05:27:53 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 05:27:53 INFO - Using env: {'DISPLAY': ':0', 05:27:53 INFO - 'HOME': '/home/cltbld', 05:27:53 INFO - 'LANG': 'en_US.UTF-8', 05:27:53 INFO - 'LANGUAGE': 'en_US:en', 05:27:53 INFO - 'LOGNAME': 'cltbld', 05:27:53 INFO - 'MAIL': '/var/mail/cltbld', 05:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:53 INFO - 'MOZ_NO_REMOTE': '1', 05:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:53 INFO - 'NO_EM_RESTART': '1', 05:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:53 INFO - 'PWD': '/builds/slave/test', 05:27:53 INFO - 'SHELL': '/bin/bash', 05:27:53 INFO - 'SHLVL': '1', 05:27:53 INFO - 'TERM': 'linux', 05:27:53 INFO - 'TMOUT': '86400', 05:27:53 INFO - 'USER': 'cltbld', 05:27:53 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659', 05:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:53 INFO - '_': '/tools/buildbot/bin/python'} 05:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:53 INFO - Running setup.py (path:/tmp/pip-SeGeHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:53 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)) 05:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:53 INFO - Running setup.py (path:/tmp/pip-2u0YKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:53 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)) 05:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:53 INFO - Running setup.py (path:/tmp/pip-R2fvKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:53 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)) 05:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:53 INFO - Running setup.py (path:/tmp/pip-ONpU6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:53 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)) 05:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:54 INFO - Running setup.py (path:/tmp/pip-92AMLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:54 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)) 05:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:54 INFO - Running setup.py (path:/tmp/pip-wViO70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:54 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)) 05:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:54 INFO - Running setup.py (path:/tmp/pip-urq6kK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:54 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)) 05:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:54 INFO - Running setup.py (path:/tmp/pip-Ghtd5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:54 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)) 05:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:54 INFO - Running setup.py (path:/tmp/pip-7HKVtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:54 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)) 05:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:54 INFO - Running setup.py (path:/tmp/pip-mQ3BL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:54 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)) 05:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:54 INFO - Running setup.py (path:/tmp/pip-yLKL4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:54 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)) 05:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:54 INFO - Running setup.py (path:/tmp/pip-hEix7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:54 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)) 05:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:54 INFO - Running setup.py (path:/tmp/pip-MqNrQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:54 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)) 05:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:54 INFO - Running setup.py (path:/tmp/pip-QvpeiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:54 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)) 05:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:54 INFO - Running setup.py (path:/tmp/pip-CE_f8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:54 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)) 05:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:54 INFO - Running setup.py (path:/tmp/pip-y5aTQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:54 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)) 05:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:54 INFO - Running setup.py (path:/tmp/pip-D6bVgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:54 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)) 05:27:54 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)) 05:27:54 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)) 05:27:54 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)) 05:27:54 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)) 05:27:54 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)) 05:27:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:27:54 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 05:27:54 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 05:27:54 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 05:27:54 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 05:27:54 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 05:27:54 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 05:27:56 INFO - Downloading blessings-1.6.tar.gz 05:27:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:27:56 INFO - Installing collected packages: blessings 05:27:56 INFO - Running setup.py install for blessings 05:27:57 INFO - Successfully installed blessings 05:27:57 INFO - Cleaning up... 05:27:57 INFO - Return code: 0 05:27:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:27:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:57 INFO - Reading from file tmpfile_stdout 05:27:57 INFO - Current package versions: 05:27:57 INFO - argparse == 1.2.1 05:27:57 INFO - blessings == 1.6 05:27:57 INFO - blobuploader == 1.2.4 05:27:57 INFO - docopt == 0.6.1 05:27:57 INFO - functools32 == 3.2.3-2 05:27:57 INFO - jsonschema == 2.5.1 05:27:57 INFO - manifestparser == 1.1 05:27:57 INFO - mozInstall == 1.12 05:27:57 INFO - mozcrash == 0.17 05:27:57 INFO - mozdebug == 0.1 05:27:57 INFO - mozdevice == 0.48 05:27:57 INFO - mozfile == 1.2 05:27:57 INFO - mozhttpd == 0.7 05:27:57 INFO - mozinfo == 0.9 05:27:57 INFO - mozleak == 0.1 05:27:57 INFO - mozlog == 3.3 05:27:57 INFO - moznetwork == 0.27 05:27:57 INFO - mozprocess == 0.23 05:27:57 INFO - mozprofile == 0.28 05:27:57 INFO - mozrunner == 6.12 05:27:57 INFO - mozscreenshot == 0.1 05:27:57 INFO - mozsystemmonitor == 0.3 05:27:57 INFO - moztest == 0.7 05:27:57 INFO - mozversion == 1.4 05:27:57 INFO - psutil == 3.1.1 05:27:57 INFO - requests == 1.2.3 05:27:57 INFO - wsgiref == 0.1.2 05:27:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:57 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 0x1129030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1358400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e7570>, '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 0x13e8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e8900>, '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': '523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659', '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 05:27:57 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 05:27:57 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 05:27:57 INFO - Using env: {'DISPLAY': ':0', 05:27:57 INFO - 'HOME': '/home/cltbld', 05:27:57 INFO - 'LANG': 'en_US.UTF-8', 05:27:57 INFO - 'LANGUAGE': 'en_US:en', 05:27:57 INFO - 'LOGNAME': 'cltbld', 05:27:57 INFO - 'MAIL': '/var/mail/cltbld', 05:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:57 INFO - 'MOZ_NO_REMOTE': '1', 05:27:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:57 INFO - 'NO_EM_RESTART': '1', 05:27:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:57 INFO - 'PWD': '/builds/slave/test', 05:27:57 INFO - 'SHELL': '/bin/bash', 05:27:57 INFO - 'SHLVL': '1', 05:27:57 INFO - 'TERM': 'linux', 05:27:57 INFO - 'TMOUT': '86400', 05:27:57 INFO - 'USER': 'cltbld', 05:27:57 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659', 05:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:57 INFO - '_': '/tools/buildbot/bin/python'} 05:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:57 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)) 05:27:57 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)) 05:27:57 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)) 05:27:57 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)) 05:27:57 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)) 05:27:57 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)) 05:27:57 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)) 05:27:57 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)) 05:27:57 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)) 05:27:57 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)) 05:27:57 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)) 05:27:57 INFO - Cleaning up... 05:27:57 INFO - Return code: 0 05:27:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:57 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 0x1129030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1358400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e7570>, '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 0x13e8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e8900>, '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': '523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659', '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 05:27:57 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 05:27:57 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 05:27:57 INFO - Using env: {'DISPLAY': ':0', 05:27:57 INFO - 'HOME': '/home/cltbld', 05:27:57 INFO - 'LANG': 'en_US.UTF-8', 05:27:57 INFO - 'LANGUAGE': 'en_US:en', 05:27:57 INFO - 'LOGNAME': 'cltbld', 05:27:57 INFO - 'MAIL': '/var/mail/cltbld', 05:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:57 INFO - 'MOZ_NO_REMOTE': '1', 05:27:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:57 INFO - 'NO_EM_RESTART': '1', 05:27:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:57 INFO - 'PWD': '/builds/slave/test', 05:27:57 INFO - 'SHELL': '/bin/bash', 05:27:57 INFO - 'SHLVL': '1', 05:27:57 INFO - 'TERM': 'linux', 05:27:57 INFO - 'TMOUT': '86400', 05:27:57 INFO - 'USER': 'cltbld', 05:27:57 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659', 05:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:57 INFO - '_': '/tools/buildbot/bin/python'} 05:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:27:57 INFO - Cleaning up... 05:27:57 INFO - Return code: 0 05:27:57 INFO - Running post-action listener: _resource_record_post_action 05:27:57 INFO - Running post-action listener: _start_resource_monitoring 05:27:57 INFO - Starting resource monitoring. 05:27:57 INFO - [mozharness: 2016-08-16 12:27:57.784144Z] Finished create-virtualenv step (success) 05:27:57 INFO - [mozharness: 2016-08-16 12:27:57.784628Z] Running install step. 05:27:57 INFO - Running pre-action listener: _resource_record_pre_action 05:27:57 INFO - Running main action method: install 05:27:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:57 INFO - Reading from file tmpfile_stdout 05:27:57 INFO - Detecting whether we're running mozinstall >=1.0... 05:27:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:27:58 INFO - Reading from file tmpfile_stdout 05:27:58 INFO - Output received: 05:27:58 INFO - Usage: mozinstall [options] installer 05:27:58 INFO - Options: 05:27:58 INFO - -h, --help show this help message and exit 05:27:58 INFO - -d DEST, --destination=DEST 05:27:58 INFO - Directory to install application into. [default: 05:27:58 INFO - "/builds/slave/test"] 05:27:58 INFO - --app=APP Application being installed. [default: firefox] 05:27:58 INFO - mkdir: /builds/slave/test/build/application 05:27:58 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'] 05:27:58 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 05:28:14 INFO - Reading from file tmpfile_stdout 05:28:14 INFO - Output received: 05:28:14 INFO - /builds/slave/test/build/application/firefox/firefox 05:28:14 INFO - Running post-action listener: _resource_record_post_action 05:28:14 INFO - [mozharness: 2016-08-16 12:28:14.980318Z] Finished install step (success) 05:28:14 INFO - [mozharness: 2016-08-16 12:28:14.980568Z] Running run-tests step. 05:28:14 INFO - Running pre-action listener: _resource_record_pre_action 05:28:14 INFO - Running main action method: run_tests 05:28:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:28:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:28:14 INFO - Python 2.7.3 05:28:14 INFO - Return code: 0 05:28:14 INFO - grabbing minidump binary from tooltool 05:28:14 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')]} 05:28:14 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 0x13e7570>, '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 0x13e8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e8900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:28:14 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 05:28:14 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 05:28:14 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 05:28:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:28:15 INFO - Return code: 0 05:28:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:28:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:28:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:28:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:28:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:28:15 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/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 05:28:15 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/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 05:28:15 INFO - Using env: {'DISPLAY': ':0', 05:28:15 INFO - 'HOME': '/home/cltbld', 05:28:15 INFO - 'LANG': 'en_US.UTF-8', 05:28:15 INFO - 'LANGUAGE': 'en_US:en', 05:28:15 INFO - 'LOGNAME': 'cltbld', 05:28:15 INFO - 'MAIL': '/var/mail/cltbld', 05:28:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:28:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:15 INFO - 'MOZ_NO_REMOTE': '1', 05:28:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:28:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:15 INFO - 'NO_EM_RESTART': '1', 05:28:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:15 INFO - 'PWD': '/builds/slave/test', 05:28:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:28:15 INFO - 'SHELL': '/bin/bash', 05:28:15 INFO - 'SHLVL': '1', 05:28:15 INFO - 'TERM': 'linux', 05:28:15 INFO - 'TMOUT': '86400', 05:28:15 INFO - 'USER': 'cltbld', 05:28:15 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659', 05:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:15 INFO - '_': '/tools/buildbot/bin/python'} 05:28:15 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/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 05:28:15 INFO - mozversion application_buildid: 20160816015422 05:28:15 INFO - mozversion application_changeset: 1a4509a3e2ce583753eda01ba911b34631bf207e 05:28:15 INFO - mozversion application_display_name: Nightly 05:28:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:28:15 INFO - mozversion application_name: Firefox 05:28:15 INFO - mozversion application_remotingname: firefox 05:28:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 05:28:15 INFO - mozversion application_vendor: Mozilla 05:28:15 INFO - mozversion application_version: 51.0a1 05:28:15 INFO - mozversion platform_buildid: 20160816015422 05:28:15 INFO - mozversion platform_changeset: 1a4509a3e2ce583753eda01ba911b34631bf207e 05:28:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 05:28:15 INFO - mozversion platform_version: 51.0a1 05:28:15 INFO - using testdate: 1471350495 05:28:15 INFO - actual date: 1471350495 05:28:15 INFO - starting webserver on 'localhost:46101' 05:28:15 INFO - SUITE-START | Running 2 tests 05:28:15 INFO - TEST-START | dromaeo_css 05:28:15 INFO - operating with platform_type : linux_ 05:28:15 INFO - Initialising browser for dromaeo_css test... 05:28:15 INFO - TEST-INFO | started process 726 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphcBHWZ/profile http://localhost:46101/getInfo.html) 05:28:19 INFO - PROCESS | 726 | __metrics Screen width/height:1600/1200 05:28:19 INFO - PROCESS | 726 | colorDepth:24 05:28:19 INFO - PROCESS | 726 | Browser inner width/height: 1024/697 05:28:19 INFO - PROCESS | 726 | __metrics 05:28:20 ERROR - PROCESS | 726 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 05:28:21 INFO - TEST-INFO | 726: exit 0 05:28:21 INFO - Browser initialized. 05:28:21 INFO - Running cycle 1/1 for dromaeo_css test... 05:28:21 INFO - TEST-INFO | started process 855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphcBHWZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:32 INFO - PROCESS | 855 | RSS: Main: 163680256 05:28:32 INFO - PROCESS | 855 | 05:29:22 INFO - PROCESS | 855 | 1471350562563 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:31:31 INFO - PROCESS | 855 | Cycle 1(1): loaded http://localhost:46101/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46101/tests/dromaeo/cssquery-ext.html) 05:31:32 INFO - PROCESS | 855 | RSS: Main: 167227392 05:31:32 INFO - PROCESS | 855 | 05:34:35 INFO - PROCESS | 855 | Cycle 1(1): loaded http://localhost:46101/tests/dromaeo/cssquery-ext.html (next: http://localhost:46101/tests/dromaeo/cssquery-jquery.html) 05:34:35 INFO - PROCESS | 855 | RSS: Main: 165027840 05:34:35 INFO - PROCESS | 855 | 05:37:37 INFO - PROCESS | 855 | Cycle 1(1): loaded http://localhost:46101/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46101/tests/dromaeo/cssquery-mootools.html) 05:37:38 INFO - PROCESS | 855 | RSS: Main: 166064128 05:37:38 INFO - PROCESS | 855 | 05:40:40 INFO - PROCESS | 855 | Cycle 1(1): loaded http://localhost:46101/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46101/tests/dromaeo/cssquery-prototype.html) 05:40:40 INFO - PROCESS | 855 | RSS: Main: 163442688 05:40:40 INFO - PROCESS | 855 | 05:43:43 INFO - PROCESS | 855 | Cycle 1(1): loaded http://localhost:46101/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46101/tests/dromaeo/cssquery-yui.html) 05:43:43 INFO - PROCESS | 855 | RSS: Main: 165830656 05:43:43 INFO - PROCESS | 855 | 05:46:46 INFO - PROCESS | 855 | Cycle 1(1): loaded http://localhost:46101/tests/dromaeo/cssquery-yui.html (next: http://localhost:46101/tests/dromaeo/cssquery-dojo.html) 05:46:47 INFO - PROCESS | 855 | RSS: Main: 166408192 05:46:47 INFO - PROCESS | 855 | 05:46:47 INFO - PROCESS | 855 | __start_tp_report 05:46:47 INFO - PROCESS | 855 | _x_x_mozilla_page_load 05:46:47 INFO - PROCESS | 855 | _x_x_mozilla_page_load_details 05:46:47 INFO - PROCESS | 855 | |i|pagename|runs| 05:46:47 INFO - PROCESS | 855 | |0;dojo.html;3055.0682041977198;3071.6621171671127;3078.0458058002023;3083.6145481814765;3104.56536084948;5271.182966640172;5279.392869819967;5315.681059136445;5318.042752304588;5356.089464790985;5258.368995720519;5319.441458646845;5327.121025030875;5328.866778330544;5347;4577.994231405737;4730.290456431537;4820.758962051884;4859.198232291667;4957.281194226853;4938.432080310757;4939.185034469327;4944.134776414131;4974.030064137494;5003.374578177728;4735.266033764772;4744.739039352834;4746.311784791186;4807.182778927573;4836.492168322311;4712.64655150865;4778.1638213312535;4788.401449818773;4837.7339246341435;4857.465678775332;4744.288356746481;4758.952410475886;4785.808567657289;4786.928196077061;4801.879953001203;5106.234064890259;5180.9740951295;5235.267062611238;5256.106461901486;5270.446603106657;5531.640443371168;5570.080936645449;5607.523360514361;5639.68981706006;5649.152627105926;5637.7181140942785;5639.718014099279;5641.746121424546;5689.231953686241;5694.886102277973;5166.81916132941;5239.659422137549;5267.657602255879;5284.445133261029;5335.279737235501;5812.244408226903;5861.472467477862;5865.35481097079;5878.911816322759;5895.823125306248;5559.082751346064;5570.832875013675;5573.247611572467;5579.9163012554845;5580.637258578179;5533.750981205855;5592.552595792326;5650.7174641267775;5655.519280861091;5656.179853921159;5608.439156084359;5678;5680.11958146488;5706.629069110578;5733.426657334317;5626.1842032905;5642.097264437671;5674.432556744293;5679.261695979496;5683.744231509592;4262.680298977589;4299.591538803808;4373.278409062469;4377.9781101094295;4403.779811009501;3868;3894.571597124314;3939;3940.8817735467983;3958.8614398495915;5379.515843574097;5404.270423492857;5419.783208671609;5420.83737487876;5433.565314774809;5579.414161513064;5586.13414920688;5713.971430142906;5715.742791574389;5741.913871291934;5351.384590772111;5417.83746487606;5436.401995780461;5458.426865179099;5476.288082549243;4894.94758626897;4895.559399653977;4895.902081958341;4908.705477671279;4934.975325123423;5762.423757624204;5793.333766616809;5917.437843404869;5921.496672782776;5921.940780592139;5655.830325090254;5744.3394009687745;5750.597458177887;5764.394738552392;5785.218995435731;5888.499477544457;5935.228420305332;5935.851603709942;5939.07944268639;5940.198073260228;5407.918881216863;5417.702026388586;5597.384287728428;5624.437556244343;5636.915446268227;5631.042722737063;5658.40586738403;5670.206171135962;5672.177534257592;5678.819860877921;5494.890102198014;5524.944750552604;5556.388797232382;5564.693941833238;5590.468905453975;5436.972815135899;5451.046066938349;5467.535259502828;5537.307836520435;5555.777768889199;5470.343558772973;5514.5864060194845;5514.641548299348;5529.060059789765;5532.114861622121;5522.806701765579;5523.972380138073;5530.142827861688;5571.916421253765;5583.0787919992745;5273.7363131842485;5381.3542374913695;5406.675599464044;5461.754221059982;5490.3411590609385 05:46:47 INFO - PROCESS | 855 | |1;ext.html;566.9291338582675;567.3390500067421;582.3012385137833;582.8513728999106;609.4058293164168;37967.81016094919;42552.14895702088;42629.57370426295;42680;42771.78614106933;42419.363709544385;42719;43099.13801723964;43185.78407107968;43191.35212971808;8840.77898052549;8998.68504602339;8999.685011024616;9006.054364291753;9006.144416280444;8742.431741936785;8774.341924355698;8819.29445644347;8845.734627961172;8852.734417967471;8810.603522841455;8822.514761688104;8839.46963182211;8851.60167792451;8874.86687699685;8819.426737262058;8828.161324674145;8843.248323892445;8856.601452934568;8869.68956086534;8769.254613357873;8810.559472026373;8811.867821982676;8837.425567338103;8848.424852384574;40069.79965100185;40087;40138.79930600357;40283;40284.38862445499;2510.272021113875;3372.15696075981;3385.23832137767;3491.284286721216;3521.8239088045493;28010.719892801015;28017.29956751077;29864.850675746482;30809.383812323853;31593.368132637217;4053.3717273822604;4147.3778933159965;4179.791010449465;4216.156768646283;4229.259879521102;329330;331249;332470;332635;334467;35612;35707.28585428277;35786.28427431437;35802.28395432129;35815.64184358123;36717.63282367196;37433;37689.246215075545;38625.6137438622;38732.22535549273;16883.83116168847;17096.658066838594;17122.743158852627;17144.828551714323;17231.56921076958;13000.869991299965;13138.211707297402;13177.275249861157;13177.47290108404;13274.601761947157;18689.90655046716;18697.81302186988;18738.437846864617;18849.680522363302;18925.62148757017;6643.2028156620545;6727.461803055744;6833.760818371333;6866.896996545056;6876.361383665347;957.4446820843893;992.9900700993043;1023.8157131716214;1062.1715062251455;1083.4853444613902;33000.67997280082;33112;33266;33395.49906751401;33671.663283366855;1066.9786604267872;1088.5319312695617;1143.2968724234536;1156.8264760286024;1218.9024878009739;16553.337866485446;16896.239669214916;17019.149042547822;17144.742828857576;17189.769182782282;592163;593871;597769;600855;602182;58276.41723582795;58278.125828112614;58323.70838145867;58625;58824.7058764712;1269.2130878855169;1315.8026296055477;1325.7613629546581;1333.0868355176735;1335.3456806164909;30038;31165.844170779;31437.3723808435;31889.362212756077;32315.19212019718;49772.751136244086;50015.49984500108;50252.24621630752;50336.748316258185;50419;380388;382942;385448;385844;386860;28735.425291493633;28763.71236287694;28996.565051523823;29035.12894613165;29176.56235156432;47220;48243;49045.5095449041;49146.262806057224;50020.24969625386;40434.79782601186;40562.79718601388;40651.82074929418;41669.1666166681;41819.790901046516;41128.794356028026;41360.37959430671;41532.3770143442;42292.577074228866;43171.13657726765;40826.59173408228;41491;41799;42117;42526.57473425226;34761.47857782186;36991.44512832256;37471;37551;38147.237055258185;28923.56614650824;29318.26704332409;29520.261993450335;29552.852235738683;29568 05:46:47 INFO - PROCESS | 855 | |2;jquery.html;357.9677828995388;382.96170382961697;386.3625018719113;388.5104767992329;411.0750810675979;18180.545486362847;21099.367018989455;21333.57332853342;21405.57188856222;21512.354629361125;18991.14539845707;19018.524536886584;19476.51308717283;20042.29851955182;20303.796962030374;5217.5565076968505;5748.5401167906675;5847;5878.294604647427;5942.2869255689375;5706.115552089433;5730.1118326659225;5745.798897038604;5753.424657534234;5761.567882408815;5603.411641777596;5677.120046392815;5729.28383952006;5753.510951569101;5783.855403614902;5687.459691329358;5762.711864406784;5775.826725198251;5831.6209446386065;5834.124881267822;5045.823396181153;5155.381354237516;5165.896682066337;5183.740812959337;5184.559312458446;23819.642705359434;23872.761272387226;23990.7208815164;24210.63684044741;24213.757862421327;2282.2696737044153;2287.1308902617066;2347.507023525062;2356.681847950522;3055.724984751383;14766.852331476655;14936;15010.549683509513;15056.849431505654;15152.696946061016;1914.712793081035;1919.89440580768;1943.6987266973642;1945.4260993007097;1975.911084001209;78604.21395786027;80679;80800.19199807986;81420.77868832031;82043.5897820513;10451.581936722598;10456.895431045745;10642.308249963728;10897.346159230472;10973.670789876316;14996.600543912922;15081;15095.39618415273;15142.394304227708;15203.847961520243;7863.331616812635;8103.756887293391;8109.351251899834;8314.210150035737;8327.50034997902;8018.639161237758;8163.67345306193;8174.427790054639;8271.379646526415;8301.792455188548;6266.937330626635;6618.503612229102;6644.900326495106;6728.865422691519;6772.288909664513;1910.245453046039;1929.7105434184705;1939.9709004364945;1955.3840540229783;1993.2425678242464;906.7370462565914;991.7669347703284;1016.7712264740522;1101.0860985382114;1109.944502774858;17957.102144892702;19025;19925.800741992683;19946.70079948802;20731.8963405182;981.4651015196735;990.2078337330107;999.5601935148511;1054.520193312041;1110.972225694348;10992.725181870357;11159.163062770325;11942.820857687142;12035.638930832089;12462.750744985231;516616;519382;524146;524213.2736017926;525351;95670.52164739132;97529.51235243779;100017;101001.49499252456;102593;959.9520023998772;990;1024.6772266735954;1024.8565200871883;1026.743314171457;17731.73402398991;18009.369672061413;18650.626987459902;18726.625467490303;18960.146793394608;43543.782281088395;43664;44193.55806442023;44891.775541122086;45389.54610453853;62481;63975.360246396944;64617;64705.35294646993;67065.66467167634;8745.868811967699;8770.517621530622;8827.867581986147;8929.642814287356;8990.55047247622;9337.253019758267;13013.804792928304;13522.729545409233;13843.930780346436;13983.230922299372;11687.532498700297;11796.41017949082;11888.58389956382;12025.579104731292;12189.207701499729;11630.244034137753;11657.358845263592;11706.531738730355;11857.11071669611;12079;10221.9488902555;10646.627368042082;11358.375289359165;11525.538978440769;11759.706007349885;8586.699465518677;8785.692500762443;8819.162179592928;8922.86615700778;9134.132257435533;10501.527431265764;11445.599404020819;11829.112816538965;11895.821562676394;11996.880031199576 05:46:47 INFO - PROCESS | 855 | |3;mootools.html;1215.3072748533336;1247.7317376763995;1344.2539390638194;1733.8352856478646;1781.3854220294002;7883.1328553859175;8253.38099642527;8612.09572994836;8918.42030268033;8933.374663773531;8709.390342676015;9014.323925705565;9033.90966090339;9037.774055648611;9047.45715257085;2291.3698732848434;2323.035940084863;2325.1280769711357;2333.801626861719;2340.918067867625;2287.611106111965;2305.976940230593;2353.7763912428377;2354.458474550854;2357.210334537932;2321.8606883586954;2325.476767727256;2329.2779238436055;2378.1319818266293;2385.451346190377;2255.3121298004103;2268.5576312618964;2282.7945484906354;2287.4167087392693;2314.5370925814736;2264.0717305904664;2280.1221529711015;2282.1213832674375;2282.577723121228;2283.3720726800098;8902.510361930092;8983.146601072887;9032.954835225848;9039.322050846213;9043.457392556402;5112.36095488064;5276.841694749125;5277.918026804534;5279.5512381447625;5296.761645725952;3159.462891308483;3229.273413481971;3269.117338318664;3369.4777309517062;3420.675035871588;1034.3380236648552;1038.0346277961494;1049.2759995603085;1063.2450959818539;1095.0418383914075;12176.086793490524;12201.145919785618;12267.263964162179;12324.81512777309;12328.691782705415;4242.957570424318;4359.280718681445;4446.244138496463;4473.619742321874;4501.842435514807;10400.531976061095;10466.68599942003;10497.790044199073;10497.895021049844;10503.52734126966;5177.559907407837;5186.377634683862;5190.6107041972;5233.5551478124025;5235.476452354734;4313.202057619351;4654.232051711429;4759.809607615726;4779;4815.6388270879825;3599.820008999592;3703.8703645372284;3791.109089363997;3793.468914351993;3859.517560304962;1168.4449886303937;1176.4470698771563;1180.9527618895147;1185.6561597136733;1195.2947760821157;969.699393188114;986.2603047714215;994.8607194992707;1016.0195411428008;1028.711960651019;5644.322681278273;5670.837478316935;5704.629199102128;5746.0519014363;5747.339056008529;448.89002194461915;450.64399124691124;457.57445575615;458.11812261396676;464.4357106116085;4152.418661387408;4157.97921010399;4187.97906010468;4233.597808208216;4258.638015768633;9886.30795844284;10028.849567256351;10149.797004060025;10152.54313555877;10206.489675516343;9910.80178396428;10008.14930730896;10023.198144148451;10058.396496210251;10088.49557522121;7643;7664.540127592362;7847.450678452454;8126.22800833908;8145.633446494922;6010.226983039926;6163.96918015425;6236.812895613139;6276.340984196776;6395.904061438989;10069.144122749356;10168.440735759308;10332.225083118647;10362.171026318027;10376.533056012346;10383.221258405802;10403.115735162595;10410.791784164123;10437.843432348369;10467.790644186922;7290.416766658548;7737.381009519338;7917.247861453153;7936.365090792839;7998.080220774453;8771.122887711177;8814.118588141135;8865.68970086044;8886.37795354319;8896.332775041768;7812.726554570563;7898.447108702336;8032.156623554442;8046.316063134699;8066.677332906618;7507.812304692427;7509.88735168962;7511.723007088917;7538.924610753822;7559.811004724926;6792;6903.861922761416;6940.548864323803;6956.686949087404;6965.268646792217;5131.692098474104;5174.14626586624;5193.610479213999;5274.235235890851;5458.508734213781;5315.176147697113;5328.946710532845;5385.299911011543;5420.620556561003;5545.029619816597 05:46:47 INFO - PROCESS | 855 | |4;prototype.html;312.2817519704679;322.6676523181123;324.62343681329634;325.5393618030487;328.4908391992412;5342.519173274404;5445.292112025441;5543.528800051995;5557.3886872444045;5594.132909399044;5472.2338872557875;5489.670619762807;5498.780048798053;5501.229827824108;5516.255305533752;4287.4426324577835;4293.978530107361;4295.165190973958;4298.742075475481;4309.31051031835;4201.852935147271;4287.614114729674;4332.84835030774;4339.522652508222;4349.934750978738;4288.270993931039;4290.334998075304;4296.849610263642;4308.116836048618;4316.352547117926;4307.138572285539;4312.547182545819;4334.523202447728;4339.891502712426;4348.152110338454;3542.769719968194;3831.233753249361;3841.8463261469506;3843.4811300474357;3850.7304488685522;5364.758585863607;5398;5405.324334458192;5405.513463806654;5429.4027656957705;4860.538248866387;4897.436794768576;4903.670756390721;4910.803567857281;4951.3810773653295;5464.590155738336;5715.428457154293;5787.913181302284;5806.332271788714;5818.796342128006;4059.8985025374304;4068.227036863016;4070.1656160487028;4073.388991651246;4076.7973447832665;5984;6010.819675409701;6035.396460353973;6038.788642397495;6049.939500604982;4047.332190188586;4118.8673114893645;4155.688323375759;4200.180964711852;4218.924174335525;4234.13200293939;4243.554426785205;4248.660107191479;4249.171411574714;4274.487061552633;4848.660593758474;4903.387076615423;4908.312836202935;4913.926291105637;4932.087563800708;5642.830715078554;5861.6189947653265;5863.70681465925;5889.793857214977;5910.940890591125;1451.1280448221887;1454.3891565542497;1459.5621313606089;1459.919704416246;1467.1123969998212;878.8418084744679;912.8950170730318;922.1608336413831;926.2543652359915;928.661038720862;4879.707217566957;4910.337104490848;4927.329139790807;4932.778024988884;4932.8520144395725;5235.921461178085;5237.371515418098;5247.475252474798;5263.078991159867;5345.839624811262;4670.626349892068;4967.776450059756;4988.707453081021;4996.525330093636;5008.070278886819;2777.847218402967;2782.5826126080847;2790.8928758786988;2791.8972006057897;2797.4684809886057;5310.336207974004;5315.229291752674;5341.866453338697;5344.621643368741;5377.919331210035;5270.525652691276;5299.8410047698635;5560.944390556043;6066.272047354346;6141.631502109888;6233.657148856766;6235.844103897439;6244.687765611701;6245.96877015612;6261.812145635638;5849.676794117333;5911.822645320475;6038.154658347923;6039.308993481832;6048.274207095177;5851.531877449879;5886.558508111823;5920.348761636303;5923.585349025527;5951.523878089656;6206.255249370104;6229.221347331583;6233.96883015582;6237.319981211107;6272.372762723691;3939.6454319111417;4048.3725022621543;4120.072983578791;4168.624823765876;4179.9582004179565;5962.403759624003;5975.551833612583;5981.41492504478;5986.408155106901;5992.970035149797;5752.28096487939;5781.21953536284;5861.589688721919;5866.2373891393845;5901.881962360643;5738.5696072795545;5768.567357448292;5786.871560045751;5809;5816.970915145397;5738.512226460798;5778.711064446677;5812.128180772918;5822.912656310074;5837.708114594338;5620.213170156263;5758.193852860519;5776.971115144397;5830.416958304136;5860.2967643883;5685;5697.772089116389;5699.971500142473;5755.280589926259;5783.624064435799 05:46:47 INFO - PROCESS | 855 | |5;yui.html;742.5693098003155;750.6809605917485;804.9315808156307;850.2857599616322;859.1022381611216;15284.694306113872;16489.587760305967;16533.68528406021;16585.170741462924;16667;13984.860151398483;14119.929400352983;14142.646433839134;14164.71670566588;14204.147751134913;643.2474005413677;784.6861255497789;786.5831109511968;801.2788490358665;806.7942674617993;797.696875187428;800.5716941436333;804.0190967020226;805.685782544808;808.6522795198063;852.471467690033;853.4409961475244;859.5229647545609;862.3790870573177;865.1219012702112;858.4977787994031;859.5659192107977;859.6346552715103;860.6944534690189;862.3963225742006;621.2358798677607;621.8258887511504;622.3838399983983;622.5735371270649;625.5558553427072;13634.181949083088;13825.585232443043;13831.446742130303;13834.861651383559;13879.930600347034;15869.761953570705;15967.520974370671;16082.839171608251;16190.83809161905;16229.513114606581;12477.75044499114;12510.124291299613;12546.372681365987;12547.686307842285;12563.874361256361;3934.409838524244;3937.4684417603544;3938.6455219030427;3998.52017757868;4015.7791321477307;83015.58492207501;84344.57827710945;84380.57809710974;85333.57333213295;88250.11749882484;12103.818442723366;12237.143399962095;12238.265704057785;12253.448594813255;12271.631851044483;23573.88213058958;23638.29085127449;23663.053477861038;23730.525389492457;23765.7623423767;8145.959270203611;8181.67273309061;8257.587120643944;8554.914450855536;8693.956530217309;4697.107549565571;4717.8112875485285;4793.257045158006;4811.927821082687;4857.732824694675;3478.9304213916084;3609.296187243462;3619.94570081449;3632.9818350908604;3643.3988391915036;593.1814096546738;595.3659352789266;596.6986671730748;605.6214865708932;617.7745123030152;581.5347721822525;652.353344802556;698.7344808972558;703.8803403421329;771.9768406947801;9405.106514881076;9941.105300522988;10099;10391.168706503462;10676.145908327315;632.3392055302128;731.6012773038707;743.7322563877;759.7986533568609;779.719301051621;4622.930656040095;5042.243663450512;5073;5075.974620126875;5122.487751224922;72165;72615.63692181505;74581.25418745851;132936.3353183228;133436.33281833722;111689.92186054778;113968;115326.42336788263;116046;116987.41506292584;93734.53132734292;98972;99884;100597;101068.49465752771;9128.45229286245;9296.72109836706;9566.186874115778;9617.807643847224;9685.612575496902;44851.775741121084;54768;55022.44977550334;55089.44910551004;57872.13191802042;78023.60988195022;79170;87160.56419718114;87832;89938.55030724805;11835.34905580167;12253.632391028283;12503.4373453193;12623.621291361274;13017.414216360097;14458.21322793777;14570.05294655844;14654.120752754443;14713.117212967256;14978.550643480714;12271.57049503263;12921.289329086614;13355.465781368637;13459.327033648082;13493.662658433617;12543.749125017632;13221.338933053117;13551.186928784304;13616.523421680193;14476.565703028926;11909.704203424915;12337.321447320484;12519.186252893533;12520.627472811471;12682.659765080556;10279;10646.254762166574;10696.197785165989;10808.837867432152;10868.456577170951;9368;9399.248060155034;9455.993186297228;10362.222833287382;10393.84409233847 05:46:47 INFO - PROCESS | 855 | __end_tp_report 05:46:47 INFO - PROCESS | 855 | __start_cc_report 05:46:47 INFO - PROCESS | 855 | _x_x_mozilla_cycle_collect,328 05:46:47 INFO - PROCESS | 855 | __end_cc_report 05:46:47 INFO - PROCESS | 855 | __startTimestamp1471351607023__endTimestamp 05:46:47 INFO - PROCESS | 855 | 05:46:47 INFO - PROCESS | 855 | ------- Summary: start ------- 05:46:47 INFO - PROCESS | 855 | Number of tests: 6 05:46:47 INFO - PROCESS | 855 | 05:46:47 INFO - PROCESS | 855 | [#0] dojo.html Cycles:165 Average:5267.43 Median:5467.54 stddev:594.75 (10.9%) stddev-sans-first:570.69 05:46:47 INFO - PROCESS | 855 | Values: 3055.1 3071.7 3078.0 3083.6 3104.6 5271.2 5279.4 5315.7 5318.0 5356.1 5258.4 5319.4 5327.1 5328.9 5347.0 4578.0 4730.3 4820.8 4859.2 4957.3 4938.4 4939.2 4944.1 4974.0 5003.4 4735.3 4744.7 4746.3 4807.2 4836.5 4712.6 4778.2 4788.4 4837.7 4857.5 4744.3 4759.0 4785.8 4786.9 4801.9 5106.2 5181.0 5235.3 5256.1 5270.4 5531.6 5570.1 5607.5 5639.7 5649.2 5637.7 5639.7 5641.7 5689.2 5694.9 5166.8 5239.7 5267.7 5284.4 5335.3 5812.2 5861.5 5865.4 5878.9 5895.8 5559.1 5570.8 5573.2 5579.9 5580.6 5533.8 5592.6 5650.7 5655.5 5656.2 5608.4 5678.0 5680.1 5706.6 5733.4 5626.2 5642.1 5674.4 5679.3 5683.7 4262.7 4299.6 4373.3 4378.0 4403.8 3868.0 3894.6 3939.0 3940.9 3958.9 5379.5 5404.3 5419.8 5420.8 5433.6 5579.4 5586.1 5714.0 5715.7 5741.9 5351.4 5417.8 5436.4 5458.4 5476.3 4894.9 4895.6 4895.9 4908.7 4935.0 5762.4 5793.3 5917.4 5921.5 5921.9 5655.8 5744.3 5750.6 5764.4 5785.2 5888.5 5935.2 5935.9 5939.1 5940.2 5407.9 5417.7 5597.4 5624.4 5636.9 5631.0 5658.4 5670.2 5672.2 5678.8 5494.9 5524.9 5556.4 5564.7 5590.5 5437.0 5451.0 5467.5 5537.3 5555.8 5470.3 5514.6 5514.6 5529.1 5532.1 5522.8 5524.0 5530.1 5571.9 5583.1 5273.7 5381.4 5406.7 5461.8 5490.3 05:46:47 INFO - PROCESS | 855 | 05:46:47 INFO - PROCESS | 855 | [#1] ext.html Cycles:180 Average:58674.58 Median:40112.90 stddev:120507.20 (300.4%) stddev-sans-first:120766.28 05:46:47 INFO - PROCESS | 855 | Values: 566.9 567.3 582.3 582.9 609.4 37967.8 42552.1 42629.6 42680.0 42771.8 42419.4 42719.0 43099.1 43185.8 43191.4 8840.8 8998.7 8999.7 9006.1 9006.1 8742.4 8774.3 8819.3 8845.7 8852.7 8810.6 8822.5 8839.5 8851.6 8874.9 8819.4 8828.2 8843.2 8856.6 8869.7 8769.3 8810.6 8811.9 8837.4 8848.4 40069.8 40087.0 40138.8 40283.0 40284.4 2510.3 3372.2 3385.2 3491.3 3521.8 28010.7 28017.3 29864.9 30809.4 31593.4 4053.4 4147.4 4179.8 4216.2 4229.3 329330.0 331249.0 332470.0 332635.0 334467.0 35612.0 35707.3 35786.3 35802.3 35815.6 36717.6 37433.0 37689.2 38625.6 38732.2 16883.8 17096.7 17122.7 17144.8 17231.6 13000.9 13138.2 13177.3 13177.5 13274.6 18689.9 18697.8 18738.4 18849.7 18925.6 6643.2 6727.5 6833.8 6866.9 6876.4 957.4 993.0 1023.8 1062.2 1083.5 33000.7 33112.0 33266.0 33395.5 33671.7 1067.0 1088.5 1143.3 1156.8 1218.9 16553.3 16896.2 17019.1 17144.7 17189.8 592163.0 593871.0 597769.0 600855.0 602182.0 58276.4 58278.1 58323.7 58625.0 58824.7 1269.2 1315.8 1325.8 1333.1 1335.3 30038.0 31165.8 31437.4 31889.4 32315.2 49772.8 50015.5 50252.2 50336.7 50419.0 380388.0 382942.0 385448.0 385844.0 386860.0 28735.4 28763.7 28996.6 29035.1 29176.6 47220.0 48243.0 49045.5 49146.3 50020.2 40434.8 40562.8 40651.8 41669.2 41819.8 41128.8 41360.4 41532.4 42292.6 43171.1 40826.6 41491.0 41799.0 42117.0 42526.6 34761.5 36991.4 37471.0 37551.0 38147.2 28923.6 29318.3 29520.3 29552.9 29568.0 05:46:47 INFO - PROCESS | 855 | 05:46:47 INFO - PROCESS | 855 | [#2] jquery.html Cycles:180 Average:30645.88 Median:23931.74 stddev:86066.23 (359.6%) stddev-sans-first:86277.62 05:46:47 INFO - PROCESS | 855 | Values: 358.0 383.0 386.4 388.5 411.1 18180.5 21099.4 21333.6 21405.6 21512.4 18991.1 19018.5 19476.5 20042.3 20303.8 5217.6 5748.5 5847.0 5878.3 5942.3 5706.1 5730.1 5745.8 5753.4 5761.6 5603.4 5677.1 5729.3 5753.5 5783.9 5687.5 5762.7 5775.8 5831.6 5834.1 5045.8 5155.4 5165.9 5183.7 5184.6 23819.6 23872.8 23990.7 24210.6 24213.8 2282.3 2287.1 2347.5 2356.7 3055.7 14766.9 14936.0 15010.5 15056.8 15152.7 1914.7 1919.9 1943.7 1945.4 1975.9 78604.2 80679.0 80800.2 81420.8 82043.6 10451.6 10456.9 10642.3 10897.3 10973.7 14996.6 15081.0 15095.4 15142.4 15203.8 7863.3 8103.8 8109.4 8314.2 8327.5 8018.6 8163.7 8174.4 8271.4 8301.8 6266.9 6618.5 6644.9 6728.9 6772.3 1910.2 1929.7 1940.0 1955.4 1993.2 906.7 991.8 1016.8 1101.1 1109.9 17957.1 19025.0 19925.8 19946.7 20731.9 981.5 990.2 999.6 1054.5 1111.0 10992.7 11159.2 11942.8 12035.6 12462.8 516616.0 519382.0 524146.0 524213.3 525351.0 95670.5 97529.5 100017.0 101001.5 102593.0 960.0 990.0 1024.7 1024.9 1026.7 17731.7 18009.4 18650.6 18726.6 18960.1 43543.8 43664.0 44193.6 44891.8 45389.5 62481.0 63975.4 64617.0 64705.4 67065.7 8745.9 8770.5 8827.9 8929.6 8990.6 9337.3 13013.8 13522.7 13843.9 13983.2 11687.5 11796.4 11888.6 12025.6 12189.2 11630.2 11657.4 11706.5 11857.1 12079.0 10221.9 10646.6 11358.4 11525.5 11759.7 8586.7 8785.7 8819.2 8922.9 9134.1 10501.5 11445.6 11829.1 11895.8 11996.9 05:46:47 INFO - PROCESS | 855 | 05:46:47 INFO - PROCESS | 855 | [#3] mootools.html Cycles:180 Average:5749.10 Median:449.77 stddev:3293.02 (732.2%) stddev-sans-first:3284.62 05:46:47 INFO - PROCESS | 855 | Values: 1215.3 1247.7 1344.3 1733.8 1781.4 7883.1 8253.4 8612.1 8918.4 8933.4 8709.4 9014.3 9033.9 9037.8 9047.5 2291.4 2323.0 2325.1 2333.8 2340.9 2287.6 2306.0 2353.8 2354.5 2357.2 2321.9 2325.5 2329.3 2378.1 2385.5 2255.3 2268.6 2282.8 2287.4 2314.5 2264.1 2280.1 2282.1 2282.6 2283.4 8902.5 8983.1 9033.0 9039.3 9043.5 5112.4 5276.8 5277.9 5279.6 5296.8 3159.5 3229.3 3269.1 3369.5 3420.7 1034.3 1038.0 1049.3 1063.2 1095.0 12176.1 12201.1 12267.3 12324.8 12328.7 4243.0 4359.3 4446.2 4473.6 4501.8 10400.5 10466.7 10497.8 10497.9 10503.5 5177.6 5186.4 5190.6 5233.6 5235.5 4313.2 4654.2 4759.8 4779.0 4815.6 3599.8 3703.9 3791.1 3793.5 3859.5 1168.4 1176.4 1181.0 1185.7 1195.3 969.7 986.3 994.9 1016.0 1028.7 5644.3 5670.8 5704.6 5746.1 5747.3 448.9 450.6 457.6 458.1 464.4 4152.4 4158.0 4188.0 4233.6 4258.6 9886.3 10028.8 10149.8 10152.5 10206.5 9910.8 10008.1 10023.2 10058.4 10088.5 7643.0 7664.5 7847.5 8126.2 8145.6 6010.2 6164.0 6236.8 6276.3 6395.9 10069.1 10168.4 10332.2 10362.2 10376.5 10383.2 10403.1 10410.8 10437.8 10467.8 7290.4 7737.4 7917.2 7936.4 7998.1 8771.1 8814.1 8865.7 8886.4 8896.3 7812.7 7898.4 8032.2 8046.3 8066.7 7507.8 7509.9 7511.7 7538.9 7559.8 6792.0 6903.9 6940.5 6956.7 6965.3 5131.7 5174.1 5193.6 5274.2 5458.5 5315.2 5328.9 5385.3 5420.6 5545.0 05:46:47 INFO - PROCESS | 855 | 05:46:47 INFO - PROCESS | 855 | [#4] prototype.html Cycles:180 Average:4783.17 Median:5345.23 stddev:1431.85 (26.8%) stddev-sans-first:1395.99 05:46:47 INFO - PROCESS | 855 | Values: 312.3 322.7 324.6 325.5 328.5 5342.5 5445.3 5543.5 5557.4 5594.1 5472.2 5489.7 5498.8 5501.2 5516.3 4287.4 4294.0 4295.2 4298.7 4309.3 4201.9 4287.6 4332.8 4339.5 4349.9 4288.3 4290.3 4296.8 4308.1 4316.4 4307.1 4312.5 4334.5 4339.9 4348.2 3542.8 3831.2 3841.8 3843.5 3850.7 5364.8 5398.0 5405.3 5405.5 5429.4 4860.5 4897.4 4903.7 4910.8 4951.4 5464.6 5715.4 5787.9 5806.3 5818.8 4059.9 4068.2 4070.2 4073.4 4076.8 5984.0 6010.8 6035.4 6038.8 6049.9 4047.3 4118.9 4155.7 4200.2 4218.9 4234.1 4243.6 4248.7 4249.2 4274.5 4848.7 4903.4 4908.3 4913.9 4932.1 5642.8 5861.6 5863.7 5889.8 5910.9 1451.1 1454.4 1459.6 1459.9 1467.1 878.8 912.9 922.2 926.3 928.7 4879.7 4910.3 4927.3 4932.8 4932.9 5235.9 5237.4 5247.5 5263.1 5345.8 4670.6 4967.8 4988.7 4996.5 5008.1 2777.8 2782.6 2790.9 2791.9 2797.5 5310.3 5315.2 5341.9 5344.6 5377.9 5270.5 5299.8 5560.9 6066.3 6141.6 6233.7 6235.8 6244.7 6246.0 6261.8 5849.7 5911.8 6038.2 6039.3 6048.3 5851.5 5886.6 5920.3 5923.6 5951.5 6206.3 6229.2 6234.0 6237.3 6272.4 3939.6 4048.4 4120.1 4168.6 4180.0 5962.4 5975.6 5981.4 5986.4 5993.0 5752.3 5781.2 5861.6 5866.2 5901.9 5738.6 5768.6 5786.9 5809.0 5817.0 5738.5 5778.7 5812.1 5822.9 5837.7 5620.2 5758.2 5777.0 5830.4 5860.3 5685.0 5697.8 5700.0 5755.3 5783.6 05:46:47 INFO - PROCESS | 855 | 05:46:47 INFO - PROCESS | 855 | [#5] yui.html Cycles:180 Average:21696.42 Median:4660.02 stddev:32064.42 (688.1%) stddev-sans-first:32115.77 05:46:47 INFO - PROCESS | 855 | Values: 742.6 750.7 804.9 850.3 859.1 15284.7 16489.6 16533.7 16585.2 16667.0 13984.9 14119.9 14142.6 14164.7 14204.1 643.2 784.7 786.6 801.3 806.8 797.7 800.6 804.0 805.7 808.7 852.5 853.4 859.5 862.4 865.1 858.5 859.6 859.6 860.7 862.4 621.2 621.8 622.4 622.6 625.6 13634.2 13825.6 13831.4 13834.9 13879.9 15869.8 15967.5 16082.8 16190.8 16229.5 12477.8 12510.1 12546.4 12547.7 12563.9 3934.4 3937.5 3938.6 3998.5 4015.8 83015.6 84344.6 84380.6 85333.6 88250.1 12103.8 12237.1 12238.3 12253.4 12271.6 23573.9 23638.3 23663.1 23730.5 23765.8 8146.0 8181.7 8257.6 8554.9 8694.0 4697.1 4717.8 4793.3 4811.9 4857.7 3478.9 3609.3 3619.9 3633.0 3643.4 593.2 595.4 596.7 605.6 617.8 581.5 652.4 698.7 703.9 772.0 9405.1 9941.1 10099.0 10391.2 10676.1 632.3 731.6 743.7 759.8 779.7 4622.9 5042.2 5073.0 5076.0 5122.5 72165.0 72615.6 74581.3 132936.3 133436.3 111689.9 113968.0 115326.4 116046.0 116987.4 93734.5 98972.0 99884.0 100597.0 101068.5 9128.5 9296.7 9566.2 9617.8 9685.6 44851.8 54768.0 55022.4 55089.4 57872.1 78023.6 79170.0 87160.6 87832.0 89938.6 11835.3 12253.6 12503.4 12623.6 13017.4 14458.2 14570.1 14654.1 14713.1 14978.6 12271.6 12921.3 13355.5 13459.3 13493.7 12543.7 13221.3 13551.2 13616.5 14476.6 11909.7 12337.3 12519.2 12520.6 12682.7 10279.0 10646.3 10696.2 10808.8 10868.5 9368.0 9399.2 9456.0 10362.2 10393.8 05:46:47 INFO - PROCESS | 855 | -------- Summary: end -------- 05:46:47 INFO - PROCESS | 855 | 05:46:47 INFO - TEST-INFO | 855: exit 0 05:46:47 INFO - TEST-OK | dromaeo_css | took 1112524ms 05:46:47 INFO - TEST-START | kraken 05:46:47 INFO - operating with platform_type : linux_ 05:46:47 INFO - Initialising browser for kraken test... 05:46:47 INFO - TEST-INFO | started process 1117 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjDuq73/profile http://localhost:46101/getInfo.html) 05:46:52 INFO - PROCESS | 1117 | __metrics Screen width/height:1600/1200 05:46:52 INFO - PROCESS | 1117 | colorDepth:24 05:46:52 INFO - PROCESS | 1117 | Browser inner width/height: 1024/697 05:46:52 INFO - PROCESS | 1117 | __metrics 05:46:52 ERROR - PROCESS | 1117 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 05:46:53 INFO - TEST-INFO | 1117: exit 0 05:46:53 INFO - Browser initialized. 05:46:53 INFO - Running cycle 1/1 for kraken test... 05:46:53 INFO - TEST-INFO | started process 1305 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjDuq73/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:47:05 INFO - PROCESS | 1305 | RSS: Main: 163475456 05:47:05 INFO - PROCESS | 1305 | 05:47:07 INFO - PROCESS | 1305 | Cycle 1(1): loaded http://localhost:46101/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46101/tests/kraken/driver.html?testName=audio-beat-detection) 05:47:08 INFO - PROCESS | 1305 | RSS: Main: 168341504 05:47:08 INFO - PROCESS | 1305 | 05:47:11 INFO - PROCESS | 1305 | Cycle 1(1): loaded http://localhost:46101/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46101/tests/kraken/driver.html?testName=audio-dft) 05:47:11 INFO - PROCESS | 1305 | RSS: Main: 167501824 05:47:11 INFO - PROCESS | 1305 | 05:47:14 INFO - PROCESS | 1305 | Cycle 1(1): loaded http://localhost:46101/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46101/tests/kraken/driver.html?testName=audio-fft) 05:47:15 INFO - PROCESS | 1305 | RSS: Main: 163323904 05:47:15 INFO - PROCESS | 1305 | 05:47:17 INFO - PROCESS | 1305 | Cycle 1(1): loaded http://localhost:46101/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46101/tests/kraken/driver.html?testName=audio-oscillator) 05:47:18 INFO - PROCESS | 1305 | RSS: Main: 164499456 05:47:18 INFO - PROCESS | 1305 | 05:47:20 INFO - PROCESS | 1305 | Cycle 1(1): loaded http://localhost:46101/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46101/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:47:21 INFO - PROCESS | 1305 | RSS: Main: 164315136 05:47:21 INFO - PROCESS | 1305 | 05:47:24 INFO - PROCESS | 1305 | Cycle 1(1): loaded http://localhost:46101/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46101/tests/kraken/driver.html?testName=imaging-darkroom) 05:47:24 INFO - PROCESS | 1305 | RSS: Main: 165167104 05:47:24 INFO - PROCESS | 1305 | 05:47:28 INFO - PROCESS | 1305 | Cycle 1(1): loaded http://localhost:46101/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46101/tests/kraken/driver.html?testName=imaging-desaturate) 05:47:28 INFO - PROCESS | 1305 | RSS: Main: 165494784 05:47:28 INFO - PROCESS | 1305 | 05:47:31 INFO - PROCESS | 1305 | Cycle 1(1): loaded http://localhost:46101/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46101/tests/kraken/driver.html?testName=json-parse-financial) 05:47:32 INFO - PROCESS | 1305 | RSS: Main: 165568512 05:47:32 INFO - PROCESS | 1305 | 05:47:33 INFO - PROCESS | 1305 | Cycle 1(1): loaded http://localhost:46101/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46101/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:47:34 INFO - PROCESS | 1305 | RSS: Main: 165208064 05:47:34 INFO - PROCESS | 1305 | 05:47:36 INFO - PROCESS | 1305 | Cycle 1(1): loaded http://localhost:46101/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46101/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:47:36 INFO - PROCESS | 1305 | RSS: Main: 165138432 05:47:36 INFO - PROCESS | 1305 | 05:47:39 INFO - PROCESS | 1305 | Cycle 1(1): loaded http://localhost:46101/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46101/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:47:39 INFO - PROCESS | 1305 | RSS: Main: 165539840 05:47:39 INFO - PROCESS | 1305 | 05:47:42 INFO - PROCESS | 1305 | Cycle 1(1): loaded http://localhost:46101/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46101/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:47:43 INFO - PROCESS | 1305 | RSS: Main: 166248448 05:47:43 INFO - PROCESS | 1305 | 05:47:45 INFO - PROCESS | 1305 | Cycle 1(1): loaded http://localhost:46101/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46101/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:47:46 INFO - PROCESS | 1305 | RSS: Main: 166141952 05:47:46 INFO - PROCESS | 1305 | 05:47:48 INFO - PROCESS | 1305 | Cycle 1(1): loaded http://localhost:46101/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46101/tests/kraken/driver.html?testName=ai-astar) 05:47:48 INFO - PROCESS | 1305 | RSS: Main: 166707200 05:47:48 INFO - PROCESS | 1305 | 05:47:48 INFO - PROCESS | 1305 | __start_tp_report 05:47:48 INFO - PROCESS | 1305 | _x_x_mozilla_page_load 05:47:48 INFO - PROCESS | 1305 | _x_x_mozilla_page_load_details 05:47:48 INFO - PROCESS | 1305 | |i|pagename|runs| 05:47:48 INFO - PROCESS | 1305 | |0;ai-astar;105;113;111;113;113;113;122;112;113;113 05:47:48 INFO - PROCESS | 1305 | |1;audio-beat-detection;158;117;150;187;121;150;156;122;175;119 05:47:48 INFO - PROCESS | 1305 | |2;audio-dft;164;163;164;164;165;175;163;162;162;164 05:47:48 INFO - PROCESS | 1305 | |3;audio-fft;76;76;74;180;76;76;74;76;169;75 05:47:48 INFO - PROCESS | 1305 | |4;audio-oscillator;85;88;161;86;86;87;137;86;86;150 05:47:48 INFO - PROCESS | 1305 | |5;imaging-gaussian-blur;118;117;117;118;117;117;120;118;117;117 05:47:48 INFO - PROCESS | 1305 | |6;imaging-darkroom;148;148;147;147;147;147;147;147;149;148 05:47:48 INFO - PROCESS | 1305 | |7;imaging-desaturate;96;103;95;95;96;96;96;104;97;96 05:47:48 INFO - PROCESS | 1305 | |8;json-parse-financial;51;52;55;52;52;55;54;50;52;62 05:47:48 INFO - PROCESS | 1305 | |9;json-stringify-tinderbox;63;63;63;63;69;63;62;63;64;63 05:47:48 INFO - PROCESS | 1305 | |10;stanford-crypto-aes;93;85;81;86;79;88;82;87;80;81 05:47:48 INFO - PROCESS | 1305 | |11;stanford-crypto-ccm;135;128;131;141;128;134;132;129;161;132 05:47:48 INFO - PROCESS | 1305 | |12;stanford-crypto-pbkdf2;165;170;167;164;163;179;164;165;171;165 05:47:48 INFO - PROCESS | 1305 | |13;stanford-crypto-sha256-iterative;65;66;65;68;65;65;65;67;64;66 05:47:48 INFO - PROCESS | 1305 | __end_tp_report 05:47:48 INFO - PROCESS | 1305 | __start_cc_report 05:47:48 INFO - PROCESS | 1305 | _x_x_mozilla_cycle_collect,886 05:47:48 INFO - PROCESS | 1305 | __end_cc_report 05:47:48 INFO - PROCESS | 1305 | __startTimestamp1471351668542__endTimestamp 05:47:48 INFO - PROCESS | 1305 | 05:47:48 INFO - PROCESS | 1305 | ------- Summary: start ------- 05:47:48 INFO - PROCESS | 1305 | Number of tests: 14 05:47:48 INFO - PROCESS | 1305 | 05:47:48 INFO - PROCESS | 1305 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:4.08 (3.6%) stddev-sans-first:3.20 05:47:48 INFO - PROCESS | 1305 | Values: 105.0 113.0 111.0 113.0 113.0 113.0 122.0 112.0 113.0 113.0 05:47:48 INFO - PROCESS | 1305 | 05:47:48 INFO - PROCESS | 1305 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:153.00 stddev:24.87 (16.3%) stddev-sans-first:25.96 05:47:48 INFO - PROCESS | 1305 | Values: 158.0 117.0 150.0 187.0 121.0 150.0 156.0 122.0 175.0 119.0 05:47:48 INFO - PROCESS | 1305 | 05:47:48 INFO - PROCESS | 1305 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:3.78 (2.3%) stddev-sans-first:4.00 05:47:48 INFO - PROCESS | 1305 | Values: 164.0 163.0 164.0 164.0 165.0 175.0 163.0 162.0 162.0 164.0 05:47:48 INFO - PROCESS | 1305 | 05:47:48 INFO - PROCESS | 1305 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.00 stddev:41.88 (55.1%) stddev-sans-first:43.84 05:47:48 INFO - PROCESS | 1305 | Values: 76.0 76.0 74.0 180.0 76.0 76.0 74.0 76.0 169.0 75.0 05:47:48 INFO - PROCESS | 1305 | 05:47:48 INFO - PROCESS | 1305 | [#4] audio-oscillator Cycles:10 Average:105.20 Median:86.00 stddev:30.99 (36.0%) stddev-sans-first:31.99 05:47:48 INFO - PROCESS | 1305 | Values: 85.0 88.0 161.0 86.0 86.0 87.0 137.0 86.0 86.0 150.0 05:47:48 INFO - PROCESS | 1305 | 05:47:48 INFO - PROCESS | 1305 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.50 stddev:0.97 (0.8%) stddev-sans-first:1.01 05:47:48 INFO - PROCESS | 1305 | Values: 118.0 117.0 117.0 118.0 117.0 117.0 120.0 118.0 117.0 117.0 05:47:48 INFO - PROCESS | 1305 | 05:47:48 INFO - PROCESS | 1305 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 05:47:48 INFO - PROCESS | 1305 | Values: 148.0 148.0 147.0 147.0 147.0 147.0 147.0 147.0 149.0 148.0 05:47:48 INFO - PROCESS | 1305 | 05:47:48 INFO - PROCESS | 1305 | [#7] imaging-desaturate Cycles:10 Average:97.40 Median:96.00 stddev:3.27 (3.4%) stddev-sans-first:3.43 05:47:48 INFO - PROCESS | 1305 | Values: 96.0 103.0 95.0 95.0 96.0 96.0 96.0 104.0 97.0 96.0 05:47:48 INFO - PROCESS | 1305 | 05:47:48 INFO - PROCESS | 1305 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.00 stddev:3.41 (6.4%) stddev-sans-first:3.49 05:47:48 INFO - PROCESS | 1305 | Values: 51.0 52.0 55.0 52.0 52.0 55.0 54.0 50.0 52.0 62.0 05:47:48 INFO - PROCESS | 1305 | 05:47:48 INFO - PROCESS | 1305 | [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:63.00 stddev:1.96 (3.1%) stddev-sans-first:2.06 05:47:48 INFO - PROCESS | 1305 | Values: 63.0 63.0 63.0 63.0 69.0 63.0 62.0 63.0 64.0 63.0 05:47:48 INFO - PROCESS | 1305 | 05:47:48 INFO - PROCESS | 1305 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:85.50 stddev:4.39 (5.1%) stddev-sans-first:3.31 05:47:48 INFO - PROCESS | 1305 | Values: 93.0 85.0 81.0 86.0 79.0 88.0 82.0 87.0 80.0 81.0 05:47:48 INFO - PROCESS | 1305 | 05:47:48 INFO - PROCESS | 1305 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:133.00 stddev:9.89 (7.4%) stddev-sans-first:10.49 05:47:48 INFO - PROCESS | 1305 | Values: 135.0 128.0 131.0 141.0 128.0 134.0 132.0 129.0 161.0 132.0 05:47:48 INFO - PROCESS | 1305 | 05:47:48 INFO - PROCESS | 1305 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:166.00 stddev:4.88 (2.9%) stddev-sans-first:5.10 05:47:48 INFO - PROCESS | 1305 | Values: 165.0 170.0 167.0 164.0 163.0 179.0 164.0 165.0 171.0 165.0 05:47:48 INFO - PROCESS | 1305 | 05:47:48 INFO - PROCESS | 1305 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.50 stddev:1.17 (1.8%) stddev-sans-first:1.22 05:47:48 INFO - PROCESS | 1305 | Values: 65.0 66.0 65.0 68.0 65.0 65.0 65.0 67.0 64.0 66.0 05:47:48 INFO - PROCESS | 1305 | -------- Summary: end -------- 05:47:48 INFO - PROCESS | 1305 | 05:47:49 INFO - TEST-INFO | 1305: exit 0 05:47:49 INFO - TEST-OK | kraken | took 61701ms 05:47:49 INFO - SUITE-END | took 1174s 05:47:49 INFO - Completed test suite (00:19:34) 05:47:49 INFO - javascript benchmark 05:47:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7242.198245639018, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3055.0682041977198, 3071.6621171671127, 3078.0458058002023, 3083.6145481814765, 3104.56536084948, 5271.182966640172, 5279.392869819967, 5315.681059136445, 5318.042752304588, 5356.089464790985, 5258.368995720519, 5319.441458646845, 5327.121025030875, 5328.866778330544, 5347.0, 4577.994231405737, 4730.290456431537, 4820.758962051884, 4859.198232291667, 4957.281194226853, 4938.432080310757, 4939.185034469327, 4944.134776414131, 4974.030064137494, 5003.374578177728, 4735.266033764772, 4744.739039352834, 4746.311784791186, 4807.182778927573, 4836.492168322311, 4712.64655150865, 4778.1638213312535, 4788.401449818773, 4837.7339246341435, 4857.465678775332, 4744.288356746481, 4758.952410475886, 4785.808567657289, 4786.928196077061, 4801.879953001203, 5106.234064890259, 5180.9740951295, 5235.267062611238, 5256.106461901486, 5270.446603106657, 5531.640443371168, 5570.080936645449, 5607.523360514361, 5639.68981706006, 5649.152627105926, 5637.7181140942785, 5639.718014099279, 5641.746121424546, 5689.231953686241, 5694.886102277973, 5166.81916132941, 5239.659422137549, 5267.657602255879, 5284.445133261029, 5335.279737235501, 5812.244408226903, 5861.472467477862, 5865.35481097079, 5878.911816322759, 5895.823125306248, 5559.082751346064, 5570.832875013675, 5573.247611572467, 5579.9163012554845, 5580.637258578179, 5533.750981205855, 5592.552595792326, 5650.7174641267775, 5655.519280861091, 5656.179853921159, 5608.439156084359, 5678.0, 5680.11958146488, 5706.629069110578, 5733.426657334317, 5626.1842032905, 5642.097264437671, 5674.432556744293, 5679.261695979496, 5683.744231509592, 4262.680298977589, 4299.591538803808, 4373.278409062469, 4377.9781101094295, 4403.779811009501, 3868.0, 3894.571597124314, 3939.0, 3940.8817735467983, 3958.8614398495915, 5379.515843574097, 5404.270423492857, 5419.783208671609, 5420.83737487876, 5433.565314774809, 5579.414161513064, 5586.13414920688, 5713.971430142906, 5715.742791574389, 5741.913871291934, 5351.384590772111, 5417.83746487606, 5436.401995780461, 5458.426865179099, 5476.288082549243, 4894.94758626897, 4895.559399653977, 4895.902081958341, 4908.705477671279, 4934.975325123423, 5762.423757624204, 5793.333766616809, 5917.437843404869, 5921.496672782776, 5921.940780592139, 5655.830325090254, 5744.3394009687745, 5750.597458177887, 5764.394738552392, 5785.218995435731, 5888.499477544457, 5935.228420305332, 5935.851603709942, 5939.07944268639, 5940.198073260228, 5407.918881216863, 5417.702026388586, 5597.384287728428, 5624.437556244343, 5636.915446268227, 5631.042722737063, 5658.40586738403, 5670.206171135962, 5672.177534257592, 5678.819860877921, 5494.890102198014, 5524.944750552604, 5556.388797232382, 5564.693941833238, 5590.468905453975, 5436.972815135899, 5451.046066938349, 5467.535259502828, 5537.307836520435, 5555.777768889199, 5470.343558772973, 5514.5864060194845, 5514.641548299348, 5529.060059789765, 5532.114861622121, 5522.806701765579, 5523.972380138073, 5530.142827861688, 5571.916421253765, 5583.0787919992745, 5273.7363131842485, 5381.3542374913695, 5406.675599464044, 5461.754221059982, 5490.3411590609385], "value": 5227.634760814094, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.9291338582675, 567.3390500067421, 582.3012385137833, 582.8513728999106, 609.4058293164168, 37967.81016094919, 42552.14895702088, 42629.57370426295, 42680.0, 42771.78614106933, 42419.363709544385, 42719.0, 43099.13801723964, 43185.78407107968, 43191.35212971808, 8840.77898052549, 8998.68504602339, 8999.685011024616, 9006.054364291753, 9006.144416280444, 8742.431741936785, 8774.341924355698, 8819.29445644347, 8845.734627961172, 8852.734417967471, 8810.603522841455, 8822.514761688104, 8839.46963182211, 8851.60167792451, 8874.86687699685, 8819.426737262058, 8828.161324674145, 8843.248323892445, 8856.601452934568, 8869.68956086534, 8769.254613357873, 8810.559472026373, 8811.867821982676, 8837.425567338103, 8848.424852384574, 40069.79965100185, 40087.0, 40138.79930600357, 40283.0, 40284.38862445499, 2510.272021113875, 3372.15696075981, 3385.23832137767, 3491.284286721216, 3521.8239088045493, 28010.719892801015, 28017.29956751077, 29864.850675746482, 30809.383812323853, 31593.368132637217, 4053.3717273822604, 4147.3778933159965, 4179.791010449465, 4216.156768646283, 4229.259879521102, 329330.0, 331249.0, 332470.0, 332635.0, 334467.0, 35612.0, 35707.28585428277, 35786.28427431437, 35802.28395432129, 35815.64184358123, 36717.63282367196, 37433.0, 37689.246215075545, 38625.6137438622, 38732.22535549273, 16883.83116168847, 17096.658066838594, 17122.743158852627, 17144.828551714323, 17231.56921076958, 13000.869991299965, 13138.211707297402, 13177.275249861157, 13177.47290108404, 13274.601761947157, 18689.90655046716, 18697.81302186988, 18738.437846864617, 18849.680522363302, 18925.62148757017, 6643.2028156620545, 6727.461803055744, 6833.760818371333, 6866.896996545056, 6876.361383665347, 957.4446820843893, 992.9900700993043, 1023.8157131716214, 1062.1715062251455, 1083.4853444613902, 33000.67997280082, 33112.0, 33266.0, 33395.49906751401, 33671.663283366855, 1066.9786604267872, 1088.5319312695617, 1143.2968724234536, 1156.8264760286024, 1218.9024878009739, 16553.337866485446, 16896.239669214916, 17019.149042547822, 17144.742828857576, 17189.769182782282, 592163.0, 593871.0, 597769.0, 600855.0, 602182.0, 58276.41723582795, 58278.125828112614, 58323.70838145867, 58625.0, 58824.7058764712, 1269.2130878855169, 1315.8026296055477, 1325.7613629546581, 1333.0868355176735, 1335.3456806164909, 30038.0, 31165.844170779, 31437.3723808435, 31889.362212756077, 32315.19212019718, 49772.751136244086, 50015.49984500108, 50252.24621630752, 50336.748316258185, 50419.0, 380388.0, 382942.0, 385448.0, 385844.0, 386860.0, 28735.425291493633, 28763.71236287694, 28996.565051523823, 29035.12894613165, 29176.56235156432, 47220.0, 48243.0, 49045.5095449041, 49146.262806057224, 50020.24969625386, 40434.79782601186, 40562.79718601388, 40651.82074929418, 41669.1666166681, 41819.790901046516, 41128.794356028026, 41360.37959430671, 41532.3770143442, 42292.577074228866, 43171.13657726765, 40826.59173408228, 41491.0, 41799.0, 42117.0, 42526.57473425226, 34761.47857782186, 36991.44512832256, 37471.0, 37551.0, 38147.237055258185, 28923.56614650824, 29318.26704332409, 29520.261993450335, 29552.852235738683, 29568.0], "value": 19418.895167615843, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.9677828995388, 382.96170382961697, 386.3625018719113, 388.5104767992329, 411.0750810675979, 18180.545486362847, 21099.367018989455, 21333.57332853342, 21405.57188856222, 21512.354629361125, 18991.14539845707, 19018.524536886584, 19476.51308717283, 20042.29851955182, 20303.796962030374, 5217.5565076968505, 5748.5401167906675, 5847.0, 5878.294604647427, 5942.2869255689375, 5706.115552089433, 5730.1118326659225, 5745.798897038604, 5753.424657534234, 5761.567882408815, 5603.411641777596, 5677.120046392815, 5729.28383952006, 5753.510951569101, 5783.855403614902, 5687.459691329358, 5762.711864406784, 5775.826725198251, 5831.6209446386065, 5834.124881267822, 5045.823396181153, 5155.381354237516, 5165.896682066337, 5183.740812959337, 5184.559312458446, 23819.642705359434, 23872.761272387226, 23990.7208815164, 24210.63684044741, 24213.757862421327, 2282.2696737044153, 2287.1308902617066, 2347.507023525062, 2356.681847950522, 3055.724984751383, 14766.852331476655, 14936.0, 15010.549683509513, 15056.849431505654, 15152.696946061016, 1914.712793081035, 1919.89440580768, 1943.6987266973642, 1945.4260993007097, 1975.911084001209, 78604.21395786027, 80679.0, 80800.19199807986, 81420.77868832031, 82043.5897820513, 10451.581936722598, 10456.895431045745, 10642.308249963728, 10897.346159230472, 10973.670789876316, 14996.600543912922, 15081.0, 15095.39618415273, 15142.394304227708, 15203.847961520243, 7863.331616812635, 8103.756887293391, 8109.351251899834, 8314.210150035737, 8327.50034997902, 8018.639161237758, 8163.67345306193, 8174.427790054639, 8271.379646526415, 8301.792455188548, 6266.937330626635, 6618.503612229102, 6644.900326495106, 6728.865422691519, 6772.288909664513, 1910.245453046039, 1929.7105434184705, 1939.9709004364945, 1955.3840540229783, 1993.2425678242464, 906.7370462565914, 991.7669347703284, 1016.7712264740522, 1101.0860985382114, 1109.944502774858, 17957.102144892702, 19025.0, 19925.800741992683, 19946.70079948802, 20731.8963405182, 981.4651015196735, 990.2078337330107, 999.5601935148511, 1054.520193312041, 1110.972225694348, 10992.725181870357, 11159.163062770325, 11942.820857687142, 12035.638930832089, 12462.750744985231, 516616.0, 519382.0, 524146.0, 524213.2736017926, 525351.0, 95670.52164739132, 97529.51235243779, 100017.0, 101001.49499252456, 102593.0, 959.9520023998772, 990.0, 1024.6772266735954, 1024.8565200871883, 1026.743314171457, 17731.73402398991, 18009.369672061413, 18650.626987459902, 18726.625467490303, 18960.146793394608, 43543.782281088395, 43664.0, 44193.55806442023, 44891.775541122086, 45389.54610453853, 62481.0, 63975.360246396944, 64617.0, 64705.35294646993, 67065.66467167634, 8745.868811967699, 8770.517621530622, 8827.867581986147, 8929.642814287356, 8990.55047247622, 9337.253019758267, 13013.804792928304, 13522.729545409233, 13843.930780346436, 13983.230922299372, 11687.532498700297, 11796.41017949082, 11888.58389956382, 12025.579104731292, 12189.207701499729, 11630.244034137753, 11657.358845263592, 11706.531738730355, 11857.11071669611, 12079.0, 10221.9488902555, 10646.627368042082, 11358.375289359165, 11525.538978440769, 11759.706007349885, 8586.699465518677, 8785.692500762443, 8819.162179592928, 8922.86615700778, 9134.132257435533, 10501.527431265764, 11445.599404020819, 11829.112816538965, 11895.821562676394, 11996.880031199576], "value": 9563.059892144513, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1215.3072748533336, 1247.7317376763995, 1344.2539390638194, 1733.8352856478646, 1781.3854220294002, 7883.1328553859175, 8253.38099642527, 8612.09572994836, 8918.42030268033, 8933.374663773531, 8709.390342676015, 9014.323925705565, 9033.90966090339, 9037.774055648611, 9047.45715257085, 2291.3698732848434, 2323.035940084863, 2325.1280769711357, 2333.801626861719, 2340.918067867625, 2287.611106111965, 2305.976940230593, 2353.7763912428377, 2354.458474550854, 2357.210334537932, 2321.8606883586954, 2325.476767727256, 2329.2779238436055, 2378.1319818266293, 2385.451346190377, 2255.3121298004103, 2268.5576312618964, 2282.7945484906354, 2287.4167087392693, 2314.5370925814736, 2264.0717305904664, 2280.1221529711015, 2282.1213832674375, 2282.577723121228, 2283.3720726800098, 8902.510361930092, 8983.146601072887, 9032.954835225848, 9039.322050846213, 9043.457392556402, 5112.36095488064, 5276.841694749125, 5277.918026804534, 5279.5512381447625, 5296.761645725952, 3159.462891308483, 3229.273413481971, 3269.117338318664, 3369.4777309517062, 3420.675035871588, 1034.3380236648552, 1038.0346277961494, 1049.2759995603085, 1063.2450959818539, 1095.0418383914075, 12176.086793490524, 12201.145919785618, 12267.263964162179, 12324.81512777309, 12328.691782705415, 4242.957570424318, 4359.280718681445, 4446.244138496463, 4473.619742321874, 4501.842435514807, 10400.531976061095, 10466.68599942003, 10497.790044199073, 10497.895021049844, 10503.52734126966, 5177.559907407837, 5186.377634683862, 5190.6107041972, 5233.5551478124025, 5235.476452354734, 4313.202057619351, 4654.232051711429, 4759.809607615726, 4779.0, 4815.6388270879825, 3599.820008999592, 3703.8703645372284, 3791.109089363997, 3793.468914351993, 3859.517560304962, 1168.4449886303937, 1176.4470698771563, 1180.9527618895147, 1185.6561597136733, 1195.2947760821157, 969.699393188114, 986.2603047714215, 994.8607194992707, 1016.0195411428008, 1028.711960651019, 5644.322681278273, 5670.837478316935, 5704.629199102128, 5746.0519014363, 5747.339056008529, 448.89002194461915, 450.64399124691124, 457.57445575615, 458.11812261396676, 464.4357106116085, 4152.418661387408, 4157.97921010399, 4187.97906010468, 4233.597808208216, 4258.638015768633, 9886.30795844284, 10028.849567256351, 10149.797004060025, 10152.54313555877, 10206.489675516343, 9910.80178396428, 10008.14930730896, 10023.198144148451, 10058.396496210251, 10088.49557522121, 7643.0, 7664.540127592362, 7847.450678452454, 8126.22800833908, 8145.633446494922, 6010.226983039926, 6163.96918015425, 6236.812895613139, 6276.340984196776, 6395.904061438989, 10069.144122749356, 10168.440735759308, 10332.225083118647, 10362.171026318027, 10376.533056012346, 10383.221258405802, 10403.115735162595, 10410.791784164123, 10437.843432348369, 10467.790644186922, 7290.416766658548, 7737.381009519338, 7917.247861453153, 7936.365090792839, 7998.080220774453, 8771.122887711177, 8814.118588141135, 8865.68970086044, 8886.37795354319, 8896.332775041768, 7812.726554570563, 7898.447108702336, 8032.156623554442, 8046.316063134699, 8066.677332906618, 7507.812304692427, 7509.88735168962, 7511.723007088917, 7538.924610753822, 7559.811004724926, 6792.0, 6903.861922761416, 6940.548864323803, 6956.686949087404, 6965.268646792217, 5131.692098474104, 5174.14626586624, 5193.610479213999, 5274.235235890851, 5458.508734213781, 5315.176147697113, 5328.946710532845, 5385.299911011543, 5420.620556561003, 5545.029619816597], "value": 4506.709252775266, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.2817519704679, 322.6676523181123, 324.62343681329634, 325.5393618030487, 328.4908391992412, 5342.519173274404, 5445.292112025441, 5543.528800051995, 5557.3886872444045, 5594.132909399044, 5472.2338872557875, 5489.670619762807, 5498.780048798053, 5501.229827824108, 5516.255305533752, 4287.4426324577835, 4293.978530107361, 4295.165190973958, 4298.742075475481, 4309.31051031835, 4201.852935147271, 4287.614114729674, 4332.84835030774, 4339.522652508222, 4349.934750978738, 4288.270993931039, 4290.334998075304, 4296.849610263642, 4308.116836048618, 4316.352547117926, 4307.138572285539, 4312.547182545819, 4334.523202447728, 4339.891502712426, 4348.152110338454, 3542.769719968194, 3831.233753249361, 3841.8463261469506, 3843.4811300474357, 3850.7304488685522, 5364.758585863607, 5398.0, 5405.324334458192, 5405.513463806654, 5429.4027656957705, 4860.538248866387, 4897.436794768576, 4903.670756390721, 4910.803567857281, 4951.3810773653295, 5464.590155738336, 5715.428457154293, 5787.913181302284, 5806.332271788714, 5818.796342128006, 4059.8985025374304, 4068.227036863016, 4070.1656160487028, 4073.388991651246, 4076.7973447832665, 5984.0, 6010.819675409701, 6035.396460353973, 6038.788642397495, 6049.939500604982, 4047.332190188586, 4118.8673114893645, 4155.688323375759, 4200.180964711852, 4218.924174335525, 4234.13200293939, 4243.554426785205, 4248.660107191479, 4249.171411574714, 4274.487061552633, 4848.660593758474, 4903.387076615423, 4908.312836202935, 4913.926291105637, 4932.087563800708, 5642.830715078554, 5861.6189947653265, 5863.70681465925, 5889.793857214977, 5910.940890591125, 1451.1280448221887, 1454.3891565542497, 1459.5621313606089, 1459.919704416246, 1467.1123969998212, 878.8418084744679, 912.8950170730318, 922.1608336413831, 926.2543652359915, 928.661038720862, 4879.707217566957, 4910.337104490848, 4927.329139790807, 4932.778024988884, 4932.8520144395725, 5235.921461178085, 5237.371515418098, 5247.475252474798, 5263.078991159867, 5345.839624811262, 4670.626349892068, 4967.776450059756, 4988.707453081021, 4996.525330093636, 5008.070278886819, 2777.847218402967, 2782.5826126080847, 2790.8928758786988, 2791.8972006057897, 2797.4684809886057, 5310.336207974004, 5315.229291752674, 5341.866453338697, 5344.621643368741, 5377.919331210035, 5270.525652691276, 5299.8410047698635, 5560.944390556043, 6066.272047354346, 6141.631502109888, 6233.657148856766, 6235.844103897439, 6244.687765611701, 6245.96877015612, 6261.812145635638, 5849.676794117333, 5911.822645320475, 6038.154658347923, 6039.308993481832, 6048.274207095177, 5851.531877449879, 5886.558508111823, 5920.348761636303, 5923.585349025527, 5951.523878089656, 6206.255249370104, 6229.221347331583, 6233.96883015582, 6237.319981211107, 6272.372762723691, 3939.6454319111417, 4048.3725022621543, 4120.072983578791, 4168.624823765876, 4179.9582004179565, 5962.403759624003, 5975.551833612583, 5981.41492504478, 5986.408155106901, 5992.970035149797, 5752.28096487939, 5781.21953536284, 5861.589688721919, 5866.2373891393845, 5901.881962360643, 5738.5696072795545, 5768.567357448292, 5786.871560045751, 5809.0, 5816.970915145397, 5738.512226460798, 5778.711064446677, 5812.128180772918, 5822.912656310074, 5837.708114594338, 5620.213170156263, 5758.193852860519, 5776.971115144397, 5830.416958304136, 5860.2967643883, 5685.0, 5697.772089116389, 5699.971500142473, 5755.280589926259, 5783.624064435799], "value": 4318.086924358521, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.5693098003155, 750.6809605917485, 804.9315808156307, 850.2857599616322, 859.1022381611216, 15284.694306113872, 16489.587760305967, 16533.68528406021, 16585.170741462924, 16667.0, 13984.860151398483, 14119.929400352983, 14142.646433839134, 14164.71670566588, 14204.147751134913, 643.2474005413677, 784.6861255497789, 786.5831109511968, 801.2788490358665, 806.7942674617993, 797.696875187428, 800.5716941436333, 804.0190967020226, 805.685782544808, 808.6522795198063, 852.471467690033, 853.4409961475244, 859.5229647545609, 862.3790870573177, 865.1219012702112, 858.4977787994031, 859.5659192107977, 859.6346552715103, 860.6944534690189, 862.3963225742006, 621.2358798677607, 621.8258887511504, 622.3838399983983, 622.5735371270649, 625.5558553427072, 13634.181949083088, 13825.585232443043, 13831.446742130303, 13834.861651383559, 13879.930600347034, 15869.761953570705, 15967.520974370671, 16082.839171608251, 16190.83809161905, 16229.513114606581, 12477.75044499114, 12510.124291299613, 12546.372681365987, 12547.686307842285, 12563.874361256361, 3934.409838524244, 3937.4684417603544, 3938.6455219030427, 3998.52017757868, 4015.7791321477307, 83015.58492207501, 84344.57827710945, 84380.57809710974, 85333.57333213295, 88250.11749882484, 12103.818442723366, 12237.143399962095, 12238.265704057785, 12253.448594813255, 12271.631851044483, 23573.88213058958, 23638.29085127449, 23663.053477861038, 23730.525389492457, 23765.7623423767, 8145.959270203611, 8181.67273309061, 8257.587120643944, 8554.914450855536, 8693.956530217309, 4697.107549565571, 4717.8112875485285, 4793.257045158006, 4811.927821082687, 4857.732824694675, 3478.9304213916084, 3609.296187243462, 3619.94570081449, 3632.9818350908604, 3643.3988391915036, 593.1814096546738, 595.3659352789266, 596.6986671730748, 605.6214865708932, 617.7745123030152, 581.5347721822525, 652.353344802556, 698.7344808972558, 703.8803403421329, 771.9768406947801, 9405.106514881076, 9941.105300522988, 10099.0, 10391.168706503462, 10676.145908327315, 632.3392055302128, 731.6012773038707, 743.7322563877, 759.7986533568609, 779.719301051621, 4622.930656040095, 5042.243663450512, 5073.0, 5075.974620126875, 5122.487751224922, 72165.0, 72615.63692181505, 74581.25418745851, 132936.3353183228, 133436.33281833722, 111689.92186054778, 113968.0, 115326.42336788263, 116046.0, 116987.41506292584, 93734.53132734292, 98972.0, 99884.0, 100597.0, 101068.49465752771, 9128.45229286245, 9296.72109836706, 9566.186874115778, 9617.807643847224, 9685.612575496902, 44851.775741121084, 54768.0, 55022.44977550334, 55089.44910551004, 57872.13191802042, 78023.60988195022, 79170.0, 87160.56419718114, 87832.0, 89938.55030724805, 11835.34905580167, 12253.632391028283, 12503.4373453193, 12623.621291361274, 13017.414216360097, 14458.21322793777, 14570.05294655844, 14654.120752754443, 14713.117212967256, 14978.550643480714, 12271.57049503263, 12921.289329086614, 13355.465781368637, 13459.327033648082, 13493.662658433617, 12543.749125017632, 13221.338933053117, 13551.186928784304, 13616.523421680193, 14476.565703028926, 11909.704203424915, 12337.321447320484, 12519.186252893533, 12520.627472811471, 12682.659765080556, 10279.0, 10646.254762166574, 10696.197785165989, 10808.837867432152, 10868.456577170951, 9368.0, 9399.248060155034, 9455.993186297228, 10362.222833287382, 10393.84409233847], "value": 7636.600127247688, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1555.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 111.0, 113.0, 113.0, 113.0, 122.0, 112.0, 113.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 117.0, 150.0, 187.0, 121.0, 150.0, 156.0, 122.0, 175.0, 119.0], "value": 145.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 164.0, 165.0, 175.0, 163.0, 162.0, 162.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 180.0, 76.0, 76.0, 74.0, 76.0, 169.0, 75.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 161.0, 86.0, 86.0, 87.0, 137.0, 86.0, 86.0, 150.0], "value": 105.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 120.0, 118.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 149.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 103.0, 95.0, 95.0, 96.0, 96.0, 96.0, 104.0, 97.0, 96.0], "value": 97.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 55.0, 52.0, 52.0, 55.0, 54.0, 50.0, 52.0, 62.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 69.0, 63.0, 62.0, 63.0, 64.0, 63.0], "value": 63.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 85.0, 81.0, 86.0, 79.0, 88.0, 82.0, 87.0, 80.0, 81.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 128.0, 131.0, 141.0, 128.0, 134.0, 132.0, 129.0, 161.0, 132.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 170.0, 167.0, 164.0, 163.0, 179.0, 164.0, 165.0, 171.0, 165.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 68.0, 65.0, 65.0, 65.0, 67.0, 64.0, 66.0], "value": 65.6, "unit": "score"}]}]} 05:47:49 INFO - Return code: 0 05:47:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:47:49 ERROR - # TBPL SUCCESS # 05:47:49 INFO - Running post-action listener: _resource_record_post_action 05:47:49 INFO - [mozharness: 2016-08-16 12:47:49.871913Z] Finished run-tests step (success) 05:47:49 INFO - Running post-run listener: _resource_record_post_run 05:47:49 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 16384; Write bytes: 551997440; Read time: 280; Write time: 457888 05:47:49 INFO - TinderboxPrint: CPU usage
13.4% 05:47:49 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 280 05:47:49 INFO - TinderboxPrint: I/O write bytes / time
551,997,440 / 457,888 05:47:49 INFO - TinderboxPrint: CPU idle
8,240.1 (86.6%) 05:47:49 INFO - TinderboxPrint: CPU user
1,213.0 (12.8%) 05:47:49 INFO - TinderboxPrint: Swap in / out
0 / 0 05:47:49 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 261959680; Read time: 92; Write time: 263928 05:47:49 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289046528; Read time: 180; Write time: 193888 05:47:50 INFO - Running post-run listener: _upload_blobber_files 05:47:50 INFO - Blob upload gear active. 05:47:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:47:50 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 05:47:50 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'] 05:47:50 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 05:47:50 INFO - (blobuploader) - INFO - Open directory for files ... 05:47:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:47:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:47:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:51 INFO - (blobuploader) - INFO - Done attempting. 05:47:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:47:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:47:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:52 INFO - (blobuploader) - INFO - Done attempting. 05:47:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:47:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:47:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:56 INFO - (blobuploader) - INFO - Done attempting. 05:47:56 INFO - (blobuploader) - INFO - Iteration through files over. 05:47:56 INFO - Return code: 0 05:47:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:47:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:47:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4b259182855aac0646cfbb728c23648a024f2b7b488d1b22f6564e0fc4e3ba6f5c539bb6e9316bdecc29576f8f12fe42e6089c06e5ce9bc22a1e8eed483c4364", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0f5bf0dd043030214b6049e3b2e58dd70687a9d11a269da0080ff0f694c11b12aed61dd75a5eb697a80ff8cc45c217878aacefda0cdbbe2053f3edc23ce5d3f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/02b4c641549b50455fa5410acf9698c5f532ad4fc9e999afee1f5dabebd24ac5ead89ad8ac572ab45e312a1b85b421f4492bf5cffaad3e66af7da21249ff1db0"} 05:47:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:47:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:47:56 INFO - Contents: 05:47:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4b259182855aac0646cfbb728c23648a024f2b7b488d1b22f6564e0fc4e3ba6f5c539bb6e9316bdecc29576f8f12fe42e6089c06e5ce9bc22a1e8eed483c4364", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0f5bf0dd043030214b6049e3b2e58dd70687a9d11a269da0080ff0f694c11b12aed61dd75a5eb697a80ff8cc45c217878aacefda0cdbbe2053f3edc23ce5d3f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/02b4c641549b50455fa5410acf9698c5f532ad4fc9e999afee1f5dabebd24ac5ead89ad8ac572ab45e312a1b85b421f4492bf5cffaad3e66af7da21249ff1db0"} 05:47:56 INFO - Running post-run listener: copy_logs_to_upload_dir 05:47:56 INFO - Copying logs to upload dir... 05:47:56 INFO - mkdir: /builds/slave/test/build/upload/logs 05:47:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.670463 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-08-16 05:47:55.401393) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 05:47:55.404542) ========= 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=523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659 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/4b259182855aac0646cfbb728c23648a024f2b7b488d1b22f6564e0fc4e3ba6f5c539bb6e9316bdecc29576f8f12fe42e6089c06e5ce9bc22a1e8eed483c4364", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0f5bf0dd043030214b6049e3b2e58dd70687a9d11a269da0080ff0f694c11b12aed61dd75a5eb697a80ff8cc45c217878aacefda0cdbbe2053f3edc23ce5d3f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/02b4c641549b50455fa5410acf9698c5f532ad4fc9e999afee1f5dabebd24ac5ead89ad8ac572ab45e312a1b85b421f4492bf5cffaad3e66af7da21249ff1db0"} build_url:https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/MCbiQu8gS-iZO_2GrEZn_w/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/4b259182855aac0646cfbb728c23648a024f2b7b488d1b22f6564e0fc4e3ba6f5c539bb6e9316bdecc29576f8f12fe42e6089c06e5ce9bc22a1e8eed483c4364", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0f5bf0dd043030214b6049e3b2e58dd70687a9d11a269da0080ff0f694c11b12aed61dd75a5eb697a80ff8cc45c217878aacefda0cdbbe2053f3edc23ce5d3f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/02b4c641549b50455fa5410acf9698c5f532ad4fc9e999afee1f5dabebd24ac5ead89ad8ac572ab45e312a1b85b421f4492bf5cffaad3e66af7da21249ff1db0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 05:47:55.433835) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:47:55.434658) ========= 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=523ca41ca1e0623de333ad52000001bf-1471350444.193768-515672659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004278 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:47:55.519883) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 05:47:55.520617) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 05:47:55.521298) ========= ========= Total master_lag: 0.17 =========