builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1471389650.97 results: success (0) buildid: 20160816133002 builduid: 1089b5e52bda4c9bb90b128f75312d7e revision: 1eaa34d5dba1e3698785c7ffab4e5bd0f9529a0f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 16:20:50.973875) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 16:20:50.974281) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 16:20:50.974568) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 16:20:50.989403) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 16:20:50.989668) ========= 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=c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-16 16:20:51-- 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% 226M=0s 2016-08-16 16:20:51 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146786 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 16:20:51.150046) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 16:20:51.150347) ========= 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=c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014156 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 16:20:51.201852) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 16:20:51.202315) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1eaa34d5dba1e3698785c7ffab4e5bd0f9529a0f --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 1eaa34d5dba1e3698785c7ffab4e5bd0f9529a0f --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=c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-16 16:20:51,377 truncating revision to first 12 chars 2016-08-16 16:20:51,377 Setting DEBUG logging. 2016-08-16 16:20:51,377 attempt 1/10 2016-08-16 16:20:51,377 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/1eaa34d5dba1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 16:20:51,677 unpacking tar archive at: mozilla-inbound-1eaa34d5dba1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632571 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 16:20:51.849798) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 16:20:51.850078) ========= script_repo_revision: 1eaa34d5dba1e3698785c7ffab4e5bd0f9529a0f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 16:20:51.850559) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 16:20:51.850845) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 16:20:51.860269) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-16 16:20:51.860552) ========= /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=c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:20:52 INFO - MultiFileLogger online at 20160816 16:20:52 in /builds/slave/test 16:20:52 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 16:20:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:20:52 INFO - {'append_to_log': False, 16:20:52 INFO - 'base_work_dir': '/builds/slave/test', 16:20:52 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:20:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:20:52 INFO - 'branch': 'Mozilla-Inbound', 16:20:52 INFO - 'buildbot_json_path': 'buildprops.json', 16:20:52 INFO - 'config_files': ('talos/linux_config.py',), 16:20:52 INFO - 'default_actions': ('clobber', 16:20:52 INFO - 'read-buildbot-config', 16:20:52 INFO - 'download-and-extract', 16:20:52 INFO - 'populate-webroot', 16:20:52 INFO - 'create-virtualenv', 16:20:52 INFO - 'install', 16:20:52 INFO - 'run-tests'), 16:20:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:20:52 INFO - 'download_minidump_stackwalk': True, 16:20:52 INFO - 'download_symbols': 'ondemand', 16:20:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:20:52 INFO - 'tooltool.py': '/tools/tooltool.py', 16:20:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:20:52 INFO - '/tools/misc-python/virtualenv.py')}, 16:20:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:20:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:20:52 INFO - 'installer_path': 'installer.exe', 16:20:52 INFO - 'log_level': 'info', 16:20:52 INFO - 'log_name': 'talos', 16:20:52 INFO - 'log_to_console': True, 16:20:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:20:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:20:52 INFO - 'opt_config_files': (), 16:20:52 INFO - 'pip_index': False, 16:20:52 INFO - 'sps_profile': False, 16:20:52 INFO - 'sps_profile_interval': 0, 16:20:52 INFO - 'suite': 'dromaeojs-e10s', 16:20:52 INFO - 'system_bits': '32', 16:20:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:20:52 INFO - 'title': 'talos-linux64-ix-004', 16:20:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:20:52 INFO - 'use_talos_json': True, 16:20:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:20:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:20:52 INFO - 'work_dir': 'build'} 16:20:52 INFO - [mozharness: 2016-08-16 23:20:52.134170Z] Running clobber step. 16:20:52 INFO - Running pre-action listener: _resource_record_pre_action 16:20:52 INFO - Running main action method: clobber 16:20:52 INFO - rmtree: /builds/slave/test/build 16:20:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:20:52 INFO - Running post-action listener: _resource_record_post_action 16:20:52 INFO - [mozharness: 2016-08-16 23:20:52.586769Z] Finished clobber step (success) 16:20:52 INFO - [mozharness: 2016-08-16 23:20:52.586869Z] Running read-buildbot-config step. 16:20:52 INFO - Running pre-action listener: _resource_record_pre_action 16:20:52 INFO - Running main action method: read_buildbot_config 16:20:52 INFO - Using buildbot properties: 16:20:52 INFO - { 16:20:52 INFO - "project": "", 16:20:52 INFO - "product": "firefox", 16:20:52 INFO - "script_repo_revision": "production", 16:20:52 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 16:20:52 INFO - "repository": "", 16:20:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 16:20:52 INFO - "buildid": "20160816133002", 16:20:52 INFO - "pgo_build": "True", 16:20:52 INFO - "basedir": "/builds/slave/test", 16:20:52 INFO - "buildnumber": 1210, 16:20:52 INFO - "slavename": "talos-linux64-ix-004", 16:20:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:20:52 INFO - "platform": "ubuntu64_hw", 16:20:52 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:20:52 INFO - "branch": "mozilla-inbound", 16:20:52 INFO - "repo_path": "integration/mozilla-inbound", 16:20:52 INFO - "revision": "1eaa34d5dba1e3698785c7ffab4e5bd0f9529a0f", 16:20:52 INFO - "stage_platform": "linux64-pgo", 16:20:52 INFO - "builduid": "1089b5e52bda4c9bb90b128f75312d7e", 16:20:52 INFO - "slavebuilddir": "test" 16:20:52 INFO - } 16:20:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/MN49L8IwSBeDjdlPDnJ4wQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:20:52 INFO - Running post-action listener: _resource_record_post_action 16:20:52 INFO - [mozharness: 2016-08-16 23:20:52.589288Z] Finished read-buildbot-config step (success) 16:20:52 INFO - [mozharness: 2016-08-16 23:20:52.589378Z] Running download-and-extract step. 16:20:52 INFO - Running pre-action listener: _resource_record_pre_action 16:20:52 INFO - Running main action method: download_and_extract 16:20:52 INFO - mkdir: /builds/slave/test/build/tests 16:20:52 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')]} 16:20:52 INFO - trying https://queue.taskcluster.net/v1/task/MN49L8IwSBeDjdlPDnJ4wQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:20:52 INFO - Downloading https://queue.taskcluster.net/v1/task/MN49L8IwSBeDjdlPDnJ4wQ/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 16:20:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MN49L8IwSBeDjdlPDnJ4wQ/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 16:20:53 INFO - Downloaded 1361 bytes. 16:20:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:20:53 INFO - Using the following test package requirements: 16:20:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:20:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:20:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:20:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:53 INFO - u'jsshell-linux-x86_64.zip'], 16:20:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:20:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:20:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:20:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:20:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:20:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:20:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:20: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')]} 16:20:53 INFO - trying https://queue.taskcluster.net/v1/task/MN49L8IwSBeDjdlPDnJ4wQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:20:53 INFO - Downloading https://queue.taskcluster.net/v1/task/MN49L8IwSBeDjdlPDnJ4wQ/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 16:20:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MN49L8IwSBeDjdlPDnJ4wQ/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 16:20:54 INFO - Downloaded 21902827 bytes. 16:20:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 16:20:58 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 16:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:58 INFO - trying https://queue.taskcluster.net/v1/task/MN49L8IwSBeDjdlPDnJ4wQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:20:58 INFO - Downloading https://queue.taskcluster.net/v1/task/MN49L8IwSBeDjdlPDnJ4wQ/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 16:20:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MN49L8IwSBeDjdlPDnJ4wQ/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 16:20:59 INFO - Downloaded 21902827 bytes. 16:20:59 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 16:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:04 INFO - trying https://queue.taskcluster.net/v1/task/MN49L8IwSBeDjdlPDnJ4wQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:21:04 INFO - Downloading https://queue.taskcluster.net/v1/task/MN49L8IwSBeDjdlPDnJ4wQ/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 16:21:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MN49L8IwSBeDjdlPDnJ4wQ/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 16:21:05 INFO - Downloaded 14413719 bytes. 16:21:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 16:21:05 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')]} 16:21:05 INFO - trying https://queue.taskcluster.net/v1/task/MN49L8IwSBeDjdlPDnJ4wQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:21:05 INFO - Downloading https://queue.taskcluster.net/v1/task/MN49L8IwSBeDjdlPDnJ4wQ/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 16:21:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MN49L8IwSBeDjdlPDnJ4wQ/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 16:21:06 INFO - Downloaded 59543314 bytes. 16:21:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MN49L8IwSBeDjdlPDnJ4wQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:21:06 INFO - mkdir: /builds/slave/test/properties 16:21:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:21:06 INFO - Writing to file /builds/slave/test/properties/build_url 16:21:06 INFO - Contents: 16:21:06 INFO - build_url:https://queue.taskcluster.net/v1/task/MN49L8IwSBeDjdlPDnJ4wQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:21:07 INFO - Running post-action listener: _resource_record_post_action 16:21:07 INFO - Running post-action listener: set_extra_try_arguments 16:21:07 INFO - [mozharness: 2016-08-16 23:21:07.533149Z] Finished download-and-extract step (success) 16:21:07 INFO - [mozharness: 2016-08-16 23:21:07.533411Z] Running populate-webroot step. 16:21:07 INFO - Running pre-action listener: _resource_record_pre_action 16:21:07 INFO - Running main action method: populate_webroot 16:21:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:21:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:21:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:21:07 INFO - '--tppagecycles', 16:21:07 INFO - '7'], 16:21:07 INFO - 'tests': ['tsvgm']}}, 16:21:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:21:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:21:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:21:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:21:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:21:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:21:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:07 INFO - 'talos_options': ['--disable-e10s'], 16:21:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:21:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:21:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:07 INFO - 'talos_options': ['--disable-e10s'], 16:21:07 INFO - 'tests': ['damp', 'tps']}, 16:21:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:07 INFO - 'tests': ['damp', 'tps']}, 16:21:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:21:07 INFO - 'tests': ['dromaeo_dom']}, 16:21:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:21:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:21:07 INFO - 'tests': ['basic_compositor_video']}, 16:21:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:21:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:21:07 INFO - 'tests': ['a11yr', 16:21:07 INFO - 'ts_paint', 16:21:07 INFO - 'tpaint', 16:21:07 INFO - 'sessionrestore', 16:21:07 INFO - 'sessionrestore_no_auto_restore', 16:21:07 INFO - 'tabpaint']}, 16:21:07 INFO - 'other-e10s': {'tests': ['a11yr', 16:21:07 INFO - 'ts_paint', 16:21:07 INFO - 'tpaint', 16:21:07 INFO - 'sessionrestore', 16:21:07 INFO - 'sessionrestore_no_auto_restore', 16:21:07 INFO - 'tabpaint']}, 16:21:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:21:07 INFO - 'ts_paint', 16:21:07 INFO - 'tpaint', 16:21:07 INFO - 'sessionrestore', 16:21:07 INFO - 'sessionrestore_no_auto_restore', 16:21:07 INFO - 'tabpaint']}, 16:21:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:21:07 INFO - 'ts_paint', 16:21:07 INFO - 'tpaint', 16:21:07 INFO - 'sessionrestore', 16:21:07 INFO - 'sessionrestore_no_auto_restore', 16:21:07 INFO - 'tabpaint']}, 16:21:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:21:07 INFO - 'tests': ['a11yr', 16:21:07 INFO - 'ts_paint', 16:21:07 INFO - 'tpaint', 16:21:07 INFO - 'sessionrestore', 16:21:07 INFO - 'sessionrestore_no_auto_restore', 16:21:07 INFO - 'tabpaint']}, 16:21:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:21:07 INFO - 'tests': ['a11yr', 16:21:07 INFO - 'ts_paint', 16:21:07 INFO - 'tpaint', 16:21:07 INFO - 'sessionrestore', 16:21:07 INFO - 'sessionrestore_no_auto_restore', 16:21:07 INFO - 'tabpaint']}, 16:21:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:21:07 INFO - 'tests': ['tsvgx', 16:21:07 INFO - 'tsvgr_opacity', 16:21:07 INFO - 'tart', 16:21:07 INFO - 'tscrollx', 16:21:07 INFO - 'cart']}, 16:21:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:21:07 INFO - 'tsvgr_opacity', 16:21:07 INFO - 'tart', 16:21:07 INFO - 'tscrollx', 16:21:07 INFO - 'cart']}, 16:21:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:07 INFO - 'talos_options': ['--disable-e10s'], 16:21:07 INFO - 'tests': ['tp5o']}, 16:21:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:07 INFO - 'tests': ['tp5o']}, 16:21:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:07 INFO - 'talos_options': ['--disable-e10s', 16:21:07 INFO - '--xperf_path', 16:21:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:21:07 INFO - 'tests': ['tp5n']}, 16:21:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:07 INFO - 'talos_options': ['--xperf_path', 16:21:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:21:07 INFO - 'tests': ['tp5n']}}, 16:21:07 INFO - 'talos.zip': {'path': '', 16:21:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:21:07 INFO - Running post-action listener: _resource_record_post_action 16:21:07 INFO - [mozharness: 2016-08-16 23:21:07.551670Z] Finished populate-webroot step (success) 16:21:07 INFO - [mozharness: 2016-08-16 23:21:07.551757Z] Running create-virtualenv step. 16:21:07 INFO - Running pre-action listener: _resource_record_pre_action 16:21:07 INFO - Running main action method: create_virtualenv 16:21:07 INFO - Creating virtualenv /builds/slave/test/build/venv 16:21:07 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 16:21:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:21:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:21:07 INFO - Using real prefix '/usr' 16:21:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:21:08 INFO - Installing distribute.............................................................................................................................................................................................done. 16:21:10 INFO - Installing pip.................done. 16:21:10 INFO - Return code: 0 16:21:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:21:10 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')]} 16:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:10 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')]} 16:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:10 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 0x7f5e359e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf5420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d83d20>, '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 0x1d84c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d850b0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771', '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 16:21:10 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 16:21:10 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 16:21:10 INFO - Using env: {'DISPLAY': ':0', 16:21:10 INFO - 'HOME': '/home/cltbld', 16:21:10 INFO - 'LANG': 'en_US.UTF-8', 16:21:10 INFO - 'LANGUAGE': 'en_US:en', 16:21:10 INFO - 'LOGNAME': 'cltbld', 16:21:10 INFO - 'MAIL': '/var/mail/cltbld', 16:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:10 INFO - 'MOZ_NO_REMOTE': '1', 16:21:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:10 INFO - 'NO_EM_RESTART': '1', 16:21:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:10 INFO - 'PWD': '/builds/slave/test', 16:21:10 INFO - 'SHELL': '/bin/bash', 16:21:10 INFO - 'SHLVL': '1', 16:21:10 INFO - 'TERM': 'linux', 16:21:10 INFO - 'TMOUT': '86400', 16:21:10 INFO - 'USER': 'cltbld', 16:21:10 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771', 16:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:10 INFO - '_': '/tools/buildbot/bin/python'} 16:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:10 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 16:21:10 INFO - Cleaning up... 16:21:10 INFO - Return code: 0 16:21:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:21:10 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')]} 16:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:10 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')]} 16:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:10 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 0x7f5e359e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf5420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d83d20>, '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 0x1d84c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d850b0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771', '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 16:21:10 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 16:21:10 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 16:21:10 INFO - Using env: {'DISPLAY': ':0', 16:21:10 INFO - 'HOME': '/home/cltbld', 16:21:10 INFO - 'LANG': 'en_US.UTF-8', 16:21:10 INFO - 'LANGUAGE': 'en_US:en', 16:21:10 INFO - 'LOGNAME': 'cltbld', 16:21:10 INFO - 'MAIL': '/var/mail/cltbld', 16:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:10 INFO - 'MOZ_NO_REMOTE': '1', 16:21:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:10 INFO - 'NO_EM_RESTART': '1', 16:21:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:10 INFO - 'PWD': '/builds/slave/test', 16:21:10 INFO - 'SHELL': '/bin/bash', 16:21:10 INFO - 'SHLVL': '1', 16:21:10 INFO - 'TERM': 'linux', 16:21:10 INFO - 'TMOUT': '86400', 16:21:10 INFO - 'USER': 'cltbld', 16:21:10 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771', 16:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:10 INFO - '_': '/tools/buildbot/bin/python'} 16:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:10 INFO - Downloading/unpacking psutil>=3.1.1 16:21:10 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 16:21:10 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 16:21:10 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 16:21:10 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 16:21:10 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 16:21:10 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 16:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:21:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:21:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:21:12 INFO - Installing collected packages: psutil 16:21:12 INFO - Running setup.py install for psutil 16:21:12 INFO - building 'psutil._psutil_linux' extension 16:21:12 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 16:21:12 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 16:21:13 INFO - building 'psutil._psutil_posix' extension 16:21:13 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 16:21:13 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 16:21:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:21:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:21:13 INFO - Successfully installed psutil 16:21:13 INFO - Cleaning up... 16:21:13 INFO - Return code: 0 16:21:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5e359e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf5420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d83d20>, '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 0x1d84c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d850b0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771', '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 16:21:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:21:13 INFO - Using env: {'DISPLAY': ':0', 16:21:13 INFO - 'HOME': '/home/cltbld', 16:21:13 INFO - 'LANG': 'en_US.UTF-8', 16:21:13 INFO - 'LANGUAGE': 'en_US:en', 16:21:13 INFO - 'LOGNAME': 'cltbld', 16:21:13 INFO - 'MAIL': '/var/mail/cltbld', 16:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:13 INFO - 'MOZ_NO_REMOTE': '1', 16:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:13 INFO - 'NO_EM_RESTART': '1', 16:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:13 INFO - 'PWD': '/builds/slave/test', 16:21:13 INFO - 'SHELL': '/bin/bash', 16:21:13 INFO - 'SHLVL': '1', 16:21:13 INFO - 'TERM': 'linux', 16:21:13 INFO - 'TMOUT': '86400', 16:21:13 INFO - 'USER': 'cltbld', 16:21:13 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771', 16:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:13 INFO - '_': '/tools/buildbot/bin/python'} 16:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:21:15 INFO - Installing collected packages: mozsystemmonitor 16:21:15 INFO - Running setup.py install for mozsystemmonitor 16:21:15 INFO - Successfully installed mozsystemmonitor 16:21:15 INFO - Cleaning up... 16:21:15 INFO - Return code: 0 16:21:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:21:15 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')]} 16:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:15 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')]} 16:21:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:15 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 0x7f5e359e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf5420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d83d20>, '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 0x1d84c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d850b0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771', '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 16:21:15 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 16:21:15 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 16:21:15 INFO - Using env: {'DISPLAY': ':0', 16:21:15 INFO - 'HOME': '/home/cltbld', 16:21:15 INFO - 'LANG': 'en_US.UTF-8', 16:21:15 INFO - 'LANGUAGE': 'en_US:en', 16:21:15 INFO - 'LOGNAME': 'cltbld', 16:21:15 INFO - 'MAIL': '/var/mail/cltbld', 16:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:15 INFO - 'MOZ_NO_REMOTE': '1', 16:21:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:15 INFO - 'NO_EM_RESTART': '1', 16:21:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:15 INFO - 'PWD': '/builds/slave/test', 16:21:15 INFO - 'SHELL': '/bin/bash', 16:21:15 INFO - 'SHLVL': '1', 16:21:15 INFO - 'TERM': 'linux', 16:21:15 INFO - 'TMOUT': '86400', 16:21:15 INFO - 'USER': 'cltbld', 16:21:15 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771', 16:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:15 INFO - '_': '/tools/buildbot/bin/python'} 16:21:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:15 INFO - Downloading/unpacking jsonschema==2.5.1 16:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:21:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:21:17 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 16:21:17 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 16:21:17 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 16:21:17 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 16:21:17 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 16:21:17 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 16:21:17 INFO - Downloading functools32-3.2.3-2.tar.gz 16:21:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:21:17 INFO - warning: no files found matching '*.txt' 16:21:17 INFO - no previously-included directories found matching 'build' 16:21:17 INFO - no previously-included directories found matching 'dist' 16:21:17 INFO - no previously-included directories found matching '.git*' 16:21:17 INFO - Installing collected packages: jsonschema, functools32 16:21:18 INFO - Running setup.py install for functools32 16:21:18 INFO - warning: no files found matching '*.txt' 16:21:18 INFO - no previously-included directories found matching 'build' 16:21:18 INFO - no previously-included directories found matching 'dist' 16:21:18 INFO - no previously-included directories found matching '.git*' 16:21:18 INFO - Successfully installed jsonschema functools32 16:21:18 INFO - Cleaning up... 16:21:18 INFO - Return code: 0 16:21:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5e359e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf5420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d83d20>, '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 0x1d84c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d850b0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771', '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 16:21:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:21:18 INFO - Using env: {'DISPLAY': ':0', 16:21:18 INFO - 'HOME': '/home/cltbld', 16:21:18 INFO - 'LANG': 'en_US.UTF-8', 16:21:18 INFO - 'LANGUAGE': 'en_US:en', 16:21:18 INFO - 'LOGNAME': 'cltbld', 16:21:18 INFO - 'MAIL': '/var/mail/cltbld', 16:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:18 INFO - 'MOZ_NO_REMOTE': '1', 16:21:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:18 INFO - 'NO_EM_RESTART': '1', 16:21:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:18 INFO - 'PWD': '/builds/slave/test', 16:21:18 INFO - 'SHELL': '/bin/bash', 16:21:18 INFO - 'SHLVL': '1', 16:21:18 INFO - 'TERM': 'linux', 16:21:18 INFO - 'TMOUT': '86400', 16:21:18 INFO - 'USER': 'cltbld', 16:21:18 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771', 16:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:18 INFO - '_': '/tools/buildbot/bin/python'} 16:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:21:18 INFO - Cleaning up... 16:21:18 INFO - Return code: 0 16:21:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5e359e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf5420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d83d20>, '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 0x1d84c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d850b0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771', '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 16:21:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:21:18 INFO - Using env: {'DISPLAY': ':0', 16:21:18 INFO - 'HOME': '/home/cltbld', 16:21:18 INFO - 'LANG': 'en_US.UTF-8', 16:21:18 INFO - 'LANGUAGE': 'en_US:en', 16:21:18 INFO - 'LOGNAME': 'cltbld', 16:21:18 INFO - 'MAIL': '/var/mail/cltbld', 16:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:18 INFO - 'MOZ_NO_REMOTE': '1', 16:21:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:18 INFO - 'NO_EM_RESTART': '1', 16:21:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:18 INFO - 'PWD': '/builds/slave/test', 16:21:18 INFO - 'SHELL': '/bin/bash', 16:21:18 INFO - 'SHLVL': '1', 16:21:18 INFO - 'TERM': 'linux', 16:21:18 INFO - 'TMOUT': '86400', 16:21:18 INFO - 'USER': 'cltbld', 16:21:18 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771', 16:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:18 INFO - '_': '/tools/buildbot/bin/python'} 16:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:18 INFO - Downloading/unpacking blobuploader==1.2.4 16:21:18 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 16:21:18 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 16:21:18 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 16:21:18 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 16:21:18 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 16:21:18 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 16:21:20 INFO - Downloading blobuploader-1.2.4.tar.gz 16:21:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:21:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:21:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:21 INFO - Downloading docopt-0.6.1.tar.gz 16:21:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:21:21 INFO - Installing collected packages: blobuploader, requests, docopt 16:21:21 INFO - Running setup.py install for blobuploader 16:21:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:21:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:21:21 INFO - Running setup.py install for requests 16:21:21 INFO - Running setup.py install for docopt 16:21:21 INFO - Successfully installed blobuploader requests docopt 16:21:21 INFO - Cleaning up... 16:21:21 INFO - Return code: 0 16:21:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:21 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 0x7f5e359e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf5420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d83d20>, '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 0x1d84c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d850b0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771', '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 16:21:21 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 16:21:21 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 16:21:21 INFO - Using env: {'DISPLAY': ':0', 16:21:21 INFO - 'HOME': '/home/cltbld', 16:21:21 INFO - 'LANG': 'en_US.UTF-8', 16:21:21 INFO - 'LANGUAGE': 'en_US:en', 16:21:21 INFO - 'LOGNAME': 'cltbld', 16:21:21 INFO - 'MAIL': '/var/mail/cltbld', 16:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:21 INFO - 'MOZ_NO_REMOTE': '1', 16:21:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:21 INFO - 'NO_EM_RESTART': '1', 16:21:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:21 INFO - 'PWD': '/builds/slave/test', 16:21:21 INFO - 'SHELL': '/bin/bash', 16:21:21 INFO - 'SHLVL': '1', 16:21:21 INFO - 'TERM': 'linux', 16:21:21 INFO - 'TMOUT': '86400', 16:21:21 INFO - 'USER': 'cltbld', 16:21:21 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771', 16:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:21 INFO - '_': '/tools/buildbot/bin/python'} 16:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:21:22 INFO - Running setup.py (path:/tmp/pip-FJZ0ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:21:22 INFO - Running setup.py (path:/tmp/pip-L6DJqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:21:22 INFO - Running setup.py (path:/tmp/pip-f6OZ75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:21:22 INFO - Running setup.py (path:/tmp/pip-K4dx7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:21:22 INFO - Running setup.py (path:/tmp/pip-tuMouk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:21:22 INFO - Running setup.py (path:/tmp/pip-wXNOFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:21:22 INFO - Running setup.py (path:/tmp/pip-AzSNpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:21:22 INFO - Running setup.py (path:/tmp/pip-soD_so-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:21:22 INFO - Running setup.py (path:/tmp/pip-6CRLnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:21:22 INFO - Running setup.py (path:/tmp/pip-BKYFko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:21:22 INFO - Running setup.py (path:/tmp/pip-YIj70R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:21:22 INFO - Running setup.py (path:/tmp/pip-RQZ9iT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:21:22 INFO - Running setup.py (path:/tmp/pip-ZBRPAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:21:22 INFO - Running setup.py (path:/tmp/pip-CQjghc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:23 INFO - Running setup.py (path:/tmp/pip-lSSxCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:21:23 INFO - Running setup.py (path:/tmp/pip-CWSwAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:21:23 INFO - Running setup.py (path:/tmp/pip-WpiDt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:21:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:21:23 INFO - Running setup.py install for manifestparser 16:21:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:21:23 INFO - Running setup.py install for mozcrash 16:21:23 INFO - Running setup.py install for mozdebug 16:21:23 INFO - Running setup.py install for mozdevice 16:21:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:21:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:21:23 INFO - Running setup.py install for mozfile 16:21:23 INFO - Running setup.py install for mozhttpd 16:21:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:21:23 INFO - Running setup.py install for mozinfo 16:21:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:21:23 INFO - Running setup.py install for mozInstall 16:21:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:21:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:21:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:21:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:21:24 INFO - Running setup.py install for mozleak 16:21:24 INFO - Running setup.py install for mozlog 16:21:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:21:24 INFO - Running setup.py install for moznetwork 16:21:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:21:24 INFO - Running setup.py install for mozprocess 16:21:24 INFO - Running setup.py install for mozprofile 16:21:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:21:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:21:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:21:24 INFO - Running setup.py install for mozrunner 16:21:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:21:24 INFO - Running setup.py install for mozscreenshot 16:21:24 INFO - Running setup.py install for moztest 16:21:24 INFO - Running setup.py install for mozversion 16:21:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:21:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:21:25 INFO - Cleaning up... 16:21:25 INFO - Return code: 0 16:21:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:25 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 0x7f5e359e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf5420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d83d20>, '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 0x1d84c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d850b0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771', '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 16:21:25 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 16:21:25 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 16:21:25 INFO - Using env: {'DISPLAY': ':0', 16:21:25 INFO - 'HOME': '/home/cltbld', 16:21:25 INFO - 'LANG': 'en_US.UTF-8', 16:21:25 INFO - 'LANGUAGE': 'en_US:en', 16:21:25 INFO - 'LOGNAME': 'cltbld', 16:21:25 INFO - 'MAIL': '/var/mail/cltbld', 16:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:25 INFO - 'MOZ_NO_REMOTE': '1', 16:21:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:25 INFO - 'NO_EM_RESTART': '1', 16:21:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:25 INFO - 'PWD': '/builds/slave/test', 16:21:25 INFO - 'SHELL': '/bin/bash', 16:21:25 INFO - 'SHLVL': '1', 16:21:25 INFO - 'TERM': 'linux', 16:21:25 INFO - 'TMOUT': '86400', 16:21:25 INFO - 'USER': 'cltbld', 16:21:25 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771', 16:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:25 INFO - '_': '/tools/buildbot/bin/python'} 16:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:21:25 INFO - Running setup.py (path:/tmp/pip-F53QVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:21:25 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)) 16:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:21:25 INFO - Running setup.py (path:/tmp/pip-1XGUWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:21:25 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)) 16:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:21:25 INFO - Running setup.py (path:/tmp/pip-YuK0q4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:21:25 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)) 16:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:21:25 INFO - Running setup.py (path:/tmp/pip-D5gLqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:21:25 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)) 16:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:21:25 INFO - Running setup.py (path:/tmp/pip-nKr0fK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:21:25 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)) 16:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:21:25 INFO - Running setup.py (path:/tmp/pip-vNQS_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:21:25 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)) 16:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:21:25 INFO - Running setup.py (path:/tmp/pip-k8SUTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:21:25 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)) 16:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:21:25 INFO - Running setup.py (path:/tmp/pip-4vH8JW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:21:25 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)) 16:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:21:25 INFO - Running setup.py (path:/tmp/pip-JorDjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:21:25 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)) 16:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:21:25 INFO - Running setup.py (path:/tmp/pip-HTPc8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:21:26 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)) 16:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:21:26 INFO - Running setup.py (path:/tmp/pip-GF68Qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:21:26 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)) 16:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:21:26 INFO - Running setup.py (path:/tmp/pip-4cetjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:21:26 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)) 16:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:21:26 INFO - Running setup.py (path:/tmp/pip-_L67cB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:21:26 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)) 16:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:21:26 INFO - Running setup.py (path:/tmp/pip-_Y1g2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:21:26 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)) 16:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:26 INFO - Running setup.py (path:/tmp/pip-gKqZwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:26 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)) 16:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:21:26 INFO - Running setup.py (path:/tmp/pip-kY96QK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:21:26 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)) 16:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:21:26 INFO - Running setup.py (path:/tmp/pip-WI6x_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:21:26 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)) 16:21:26 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)) 16:21:26 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)) 16:21:26 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)) 16:21:26 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)) 16:21:26 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)) 16:21:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:28 INFO - Downloading blessings-1.6.tar.gz 16:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:21:28 INFO - Installing collected packages: blessings 16:21:28 INFO - Running setup.py install for blessings 16:21:28 INFO - Successfully installed blessings 16:21:28 INFO - Cleaning up... 16:21:28 INFO - Return code: 0 16:21:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:21:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:21:28 INFO - Reading from file tmpfile_stdout 16:21:28 INFO - Current package versions: 16:21:28 INFO - argparse == 1.2.1 16:21:28 INFO - blessings == 1.6 16:21:28 INFO - blobuploader == 1.2.4 16:21:28 INFO - docopt == 0.6.1 16:21:28 INFO - functools32 == 3.2.3-2 16:21:28 INFO - jsonschema == 2.5.1 16:21:28 INFO - manifestparser == 1.1 16:21:28 INFO - mozInstall == 1.12 16:21:28 INFO - mozcrash == 0.17 16:21:28 INFO - mozdebug == 0.1 16:21:28 INFO - mozdevice == 0.48 16:21:28 INFO - mozfile == 1.2 16:21:28 INFO - mozhttpd == 0.7 16:21:28 INFO - mozinfo == 0.9 16:21:28 INFO - mozleak == 0.1 16:21:28 INFO - mozlog == 3.3 16:21:28 INFO - moznetwork == 0.27 16:21:28 INFO - mozprocess == 0.23 16:21:28 INFO - mozprofile == 0.28 16:21:28 INFO - mozrunner == 6.12 16:21:28 INFO - mozscreenshot == 0.1 16:21:28 INFO - mozsystemmonitor == 0.3 16:21:28 INFO - moztest == 0.7 16:21:28 INFO - mozversion == 1.4 16:21:28 INFO - psutil == 3.1.1 16:21:28 INFO - requests == 1.2.3 16:21:28 INFO - wsgiref == 0.1.2 16:21:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21: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')]} 16:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21: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')]} 16:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:28 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 0x7f5e359e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf5420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d83d20>, '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 0x1d84c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d850b0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771', '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 16:21:28 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 16:21:28 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 16:21:28 INFO - Using env: {'DISPLAY': ':0', 16:21:28 INFO - 'HOME': '/home/cltbld', 16:21:28 INFO - 'LANG': 'en_US.UTF-8', 16:21:28 INFO - 'LANGUAGE': 'en_US:en', 16:21:28 INFO - 'LOGNAME': 'cltbld', 16:21:28 INFO - 'MAIL': '/var/mail/cltbld', 16:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:28 INFO - 'MOZ_NO_REMOTE': '1', 16:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:28 INFO - 'NO_EM_RESTART': '1', 16:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:28 INFO - 'PWD': '/builds/slave/test', 16:21:28 INFO - 'SHELL': '/bin/bash', 16:21:28 INFO - 'SHLVL': '1', 16:21:28 INFO - 'TERM': 'linux', 16:21:28 INFO - 'TMOUT': '86400', 16:21:28 INFO - 'USER': 'cltbld', 16:21:28 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771', 16:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:28 INFO - '_': '/tools/buildbot/bin/python'} 16:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:29 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)) 16:21:29 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)) 16:21:29 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)) 16:21:29 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)) 16:21:29 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)) 16:21:29 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)) 16:21:29 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)) 16:21:29 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)) 16:21:29 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)) 16:21:29 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)) 16:21:29 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)) 16:21:29 INFO - Cleaning up... 16:21:29 INFO - Return code: 0 16:21:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:21:29 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')]} 16:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:29 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')]} 16:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:29 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 0x7f5e359e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf5420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d83d20>, '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 0x1d84c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d850b0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771', '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 16:21:29 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 16:21:29 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 16:21:29 INFO - Using env: {'DISPLAY': ':0', 16:21:29 INFO - 'HOME': '/home/cltbld', 16:21:29 INFO - 'LANG': 'en_US.UTF-8', 16:21:29 INFO - 'LANGUAGE': 'en_US:en', 16:21:29 INFO - 'LOGNAME': 'cltbld', 16:21:29 INFO - 'MAIL': '/var/mail/cltbld', 16:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:29 INFO - 'MOZ_NO_REMOTE': '1', 16:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:29 INFO - 'NO_EM_RESTART': '1', 16:21:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:29 INFO - 'PWD': '/builds/slave/test', 16:21:29 INFO - 'SHELL': '/bin/bash', 16:21:29 INFO - 'SHLVL': '1', 16:21:29 INFO - 'TERM': 'linux', 16:21:29 INFO - 'TMOUT': '86400', 16:21:29 INFO - 'USER': 'cltbld', 16:21:29 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771', 16:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:29 INFO - '_': '/tools/buildbot/bin/python'} 16:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:21:29 INFO - Cleaning up... 16:21:29 INFO - Return code: 0 16:21:29 INFO - Running post-action listener: _resource_record_post_action 16:21:29 INFO - Running post-action listener: _start_resource_monitoring 16:21:29 INFO - Starting resource monitoring. 16:21:29 INFO - [mozharness: 2016-08-16 23:21:29.374752Z] Finished create-virtualenv step (success) 16:21:29 INFO - [mozharness: 2016-08-16 23:21:29.375220Z] Running install step. 16:21:29 INFO - Running pre-action listener: _resource_record_pre_action 16:21:29 INFO - Running main action method: install 16:21:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:21:29 INFO - Reading from file tmpfile_stdout 16:21:29 INFO - Detecting whether we're running mozinstall >=1.0... 16:21:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:21:29 INFO - Reading from file tmpfile_stdout 16:21:29 INFO - Output received: 16:21:29 INFO - Usage: mozinstall [options] installer 16:21:29 INFO - Options: 16:21:29 INFO - -h, --help show this help message and exit 16:21:29 INFO - -d DEST, --destination=DEST 16:21:29 INFO - Directory to install application into. [default: 16:21:29 INFO - "/builds/slave/test"] 16:21:29 INFO - --app=APP Application being installed. [default: firefox] 16:21:29 INFO - mkdir: /builds/slave/test/build/application 16:21:29 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'] 16:21:29 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 16:21:47 INFO - Reading from file tmpfile_stdout 16:21:47 INFO - Output received: 16:21:47 INFO - /builds/slave/test/build/application/firefox/firefox 16:21:47 INFO - Running post-action listener: _resource_record_post_action 16:21:47 INFO - [mozharness: 2016-08-16 23:21:47.223760Z] Finished install step (success) 16:21:47 INFO - [mozharness: 2016-08-16 23:21:47.224007Z] Running run-tests step. 16:21:47 INFO - Running pre-action listener: _resource_record_pre_action 16:21:47 INFO - Running main action method: run_tests 16:21:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:21:47 INFO - Python 2.7.3 16:21:47 INFO - Return code: 0 16:21:47 INFO - grabbing minidump binary from tooltool 16:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:47 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 0x1d83d20>, '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 0x1d84c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d850b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:21:47 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 16:21:47 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 16:21:47 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 16:21:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:21:47 INFO - Return code: 0 16:21:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:21:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:21:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:21:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:21:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:21:47 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/MN49L8IwSBeDjdlPDnJ4wQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 16:21:47 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/MN49L8IwSBeDjdlPDnJ4wQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 16:21:47 INFO - Using env: {'DISPLAY': ':0', 16:21:47 INFO - 'HOME': '/home/cltbld', 16:21:47 INFO - 'LANG': 'en_US.UTF-8', 16:21:47 INFO - 'LANGUAGE': 'en_US:en', 16:21:47 INFO - 'LOGNAME': 'cltbld', 16:21:47 INFO - 'MAIL': '/var/mail/cltbld', 16:21:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:21:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:47 INFO - 'MOZ_NO_REMOTE': '1', 16:21:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:47 INFO - 'NO_EM_RESTART': '1', 16:21:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:47 INFO - 'PWD': '/builds/slave/test', 16:21:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:21:47 INFO - 'SHELL': '/bin/bash', 16:21:47 INFO - 'SHLVL': '1', 16:21:47 INFO - 'TERM': 'linux', 16:21:47 INFO - 'TMOUT': '86400', 16:21:47 INFO - 'USER': 'cltbld', 16:21:47 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771', 16:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:47 INFO - '_': '/tools/buildbot/bin/python'} 16:21:47 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/MN49L8IwSBeDjdlPDnJ4wQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 16:21:47 INFO - mozversion application_buildid: 20160816133002 16:21:47 INFO - mozversion application_changeset: 1eaa34d5dba1e3698785c7ffab4e5bd0f9529a0f 16:21:47 INFO - mozversion application_display_name: Nightly 16:21:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:21:47 INFO - mozversion application_name: Firefox 16:21:47 INFO - mozversion application_remotingname: firefox 16:21:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:21:47 INFO - mozversion application_vendor: Mozilla 16:21:47 INFO - mozversion application_version: 51.0a1 16:21:47 INFO - mozversion platform_buildid: 20160816133002 16:21:47 INFO - mozversion platform_changeset: 1eaa34d5dba1e3698785c7ffab4e5bd0f9529a0f 16:21:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:21:47 INFO - mozversion platform_version: 51.0a1 16:21:47 INFO - using testdate: 1471389707 16:21:47 INFO - actual date: 1471389707 16:21:47 INFO - starting webserver on 'localhost:58824' 16:21:47 INFO - SUITE-START | Running 2 tests 16:21:47 INFO - TEST-START | dromaeo_css 16:21:47 INFO - operating with platform_type : linux_ 16:21:47 INFO - Initialising browser for dromaeo_css test... 16:21:47 INFO - TEST-INFO | started process 15713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEE7TUv/profile http://localhost:58824/getInfo.html) 16:21:51 INFO - PROCESS | 15713 | __metrics Screen width/height:1600/1200 16:21:51 INFO - PROCESS | 15713 | colorDepth:24 16:21:51 INFO - PROCESS | 15713 | Browser inner width/height: 1024/697 16:21:51 INFO - PROCESS | 15713 | __metrics 16:21:52 ERROR - PROCESS | 15713 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 16:21:53 INFO - TEST-INFO | 15713: exit 0 16:21:53 INFO - Browser initialized. 16:21:53 INFO - Running cycle 1/1 for dromaeo_css test... 16:21:53 INFO - TEST-INFO | started process 15834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEE7TUv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:22:05 INFO - PROCESS | 15834 | RSS: Main: 163618816 16:22:05 INFO - PROCESS | 15834 | 16:22:55 INFO - PROCESS | 15834 | 1471389774999 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] 16:25:04 INFO - PROCESS | 15834 | Cycle 1(1): loaded http://localhost:58824/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58824/tests/dromaeo/cssquery-ext.html) 16:25:05 INFO - PROCESS | 15834 | RSS: Main: 165867520 16:25:05 INFO - PROCESS | 15834 | 16:28:08 INFO - PROCESS | 15834 | Cycle 1(1): loaded http://localhost:58824/tests/dromaeo/cssquery-ext.html (next: http://localhost:58824/tests/dromaeo/cssquery-jquery.html) 16:28:08 INFO - PROCESS | 15834 | RSS: Main: 164413440 16:28:08 INFO - PROCESS | 15834 | 16:31:10 INFO - PROCESS | 15834 | Cycle 1(1): loaded http://localhost:58824/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58824/tests/dromaeo/cssquery-mootools.html) 16:31:11 INFO - PROCESS | 15834 | RSS: Main: 166572032 16:31:11 INFO - PROCESS | 15834 | 16:34:13 INFO - PROCESS | 15834 | Cycle 1(1): loaded http://localhost:58824/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58824/tests/dromaeo/cssquery-prototype.html) 16:34:13 INFO - PROCESS | 15834 | RSS: Main: 163876864 16:34:13 INFO - PROCESS | 15834 | 16:37:16 INFO - PROCESS | 15834 | Cycle 1(1): loaded http://localhost:58824/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58824/tests/dromaeo/cssquery-yui.html) 16:37:17 INFO - PROCESS | 15834 | RSS: Main: 166240256 16:37:17 INFO - PROCESS | 15834 | 16:40:20 INFO - PROCESS | 15834 | Cycle 1(1): loaded http://localhost:58824/tests/dromaeo/cssquery-yui.html (next: http://localhost:58824/tests/dromaeo/cssquery-dojo.html) 16:40:20 INFO - PROCESS | 15834 | RSS: Main: 167272448 16:40:20 INFO - PROCESS | 15834 | 16:40:20 INFO - PROCESS | 15834 | __start_tp_report 16:40:20 INFO - PROCESS | 15834 | _x_x_mozilla_page_load 16:40:20 INFO - PROCESS | 15834 | _x_x_mozilla_page_load_details 16:40:20 INFO - PROCESS | 15834 | |i|pagename|runs| 16:40:20 INFO - PROCESS | 15834 | |0;dojo.html;3103.829289389084;3127.3432579158375;3144.025352140836;3154.384894945485;3164.493681011037;5380.408155102946;5550.694711790855;5568.52667523261;5659.896320217554;5700;5556.638818476797;5561.749721262543;5589.049861523541;5615.691136987464;5644.01229784787;4981.526754958282;5070.873228169288;5082.08522465956;5123.129068058421;5194.558462530689;5147.356580427447;5151.072806894757;5155.20094385369;5200.32395788547;5220.295260139889;4912.975435122838;4963.156263435225;5017.874553136165;5091.439941606421;5106.5659418949435;5054.671446355975;5062.848114556569;5078.5175408336145;5111.437741848394;5122.948770512285;4988.376452943382;5038.370203724535;5044.445111037783;5062.11413002723;5080.79676812927;5358.33020872391;5433.8369848904595;5507.146392309199;5514.6691198528215;5544.722763861791;5930.199423077873;5936.7031648417405;5944.227250457456;5976.910346344808;5988.61074030191;5972.940270597282;5991.161237426763;5997.940020599825;6000.429959153874;6002.879942401171;5285.339332583389;5485.985092757773;5525.613207075507;5546.833594992076;5568.972155139199;6129.542179248731;6137.900360318011;6146.231721034871;6150.200473938359;6157.168782214344;5875.853103672357;5904.9704751475965;5915.970420147872;5922.526197904157;5943.524518038546;5750.84983003401;5889.676067816311;5931.7627294907725;5940.79207227745;5999.730012149464;5960.403959604005;5965;5966.463018328372;5975.970120149372;6003.5797494174985;5938.2280303560265;5956.821295361146;5962.433568810956;5964.284285885721;5969.164316995624;4286.957130428718;4395.472543294825;4427.335899615019;4428.357888106207;4435.489918659331;3963.801809909493;3968.3849003404516;3990.980045099814;3997.140614767839;4016.8393264269685;5566.304211973504;5636.633618814764;5638.661680299195;5650.943490565124;5652.63257888236;5743.396943320975;5898.793542226002;5940.138679891392;6053.636781793019;6070.605410648293;5644.491995720405;5647.040003199466;5659.660420374791;5663.065594176915;5674.602777805597;4971.850844474671;4976.4525902150735;4978.502149785065;4995.775190116454;5014.272930425068;5815.79644712433;6069.423404776539;6130.245269657117;6150.292716337678;6166.691665416712;6036.336003039574;6042.939570604238;6047.153398524298;6069.453749162597;6088.726007329769;6213.875722485615;6243.687815609111;6252.280987686474;6266.561340706106;6274.466670333073;5700.945325114867;5739.397363276963;5885.941140588539;5925.822225333247;5954.702264886651;5989.46094851448;6008.519318454601;6035.426634469718;6053.485453736482;6064.636121832704;5874.765009399747;5880.206172166702;5885.117232415001;5886.352501224947;5908.556858235564;5551.750171242385;5771;5778.191053252464;5788.131780232999;5882.088276317178;5840.503557197516;5888.735006924784;5892.793752218652;5894.557908156819;5934.258217722785;5853.473187413153;5864.296284445723;5911.438413350725;5915.053591425351;5924.8815023700145;5522;5678.20505129274;5696.259486266758;5716;5731.5701322400155 16:40:20 INFO - PROCESS | 15834 | |1;ext.html;545.1267876457157;590.9556783241256;592.668105860718;609.814006727948;622.9626222426652;36714.265714685724;40807.59192408071;41075.17849643005;41287.79356103223;41358.17283654332;43584.78207608966;44075.77962110185;44079.3388099178;44161.77919110408;44165.558344416546;8879.822403551925;8971.282297416225;9044.728658140266;9045.819083618324;9055.366124371296;8870.246029087502;8940.418872773282;8954.2836573074;8975.640974361018;8983.685571005017;8936.41913275635;8979.64081436745;9048.773780655503;9049.819003619923;9057.184853363196;8960.23837973773;9012.729618111467;9020.323475739346;9020.774480638003;9029.232515236214;8888.644454221823;8914.955425222897;8954.37319387643;8956.731298061068;8960.731178064669;42684.57315426837;42866.78566607147;42909.78545107286;43136;43395.566044339466;2514.5348110599416;3131.1389367923775;3366.4445366514497;3446.2613905879416;3488.860445582199;31586;32359.51460728091;32518.34963300721;32631.184220394443;32668.346633067205;4064.4106604542176;4069.8982525436804;4128.91742165155;4129.215449064698;4302.333138363528;312174;313219;314663;315333.99999999773;315768;34933.82533087318;35249.47125793115;35481.29037419289;35509.644903551154;35693.64306356955;36379;36439.63560364416;36494;36515.63484365176;36588.81705591455;15907.204639768197;16698.666026679643;16716.665666686597;16726.498205053867;16894.408695695838;12640.431180596896;12784.744305113845;12785.721427857326;12792.872071279355;12814;19077.90461047686;19110.23559057622;19125.713114303297;19286;19294.167054129834;7246.710131594783;7261.927380726231;7309.551300314454;7345.632718364061;7492.363149132276;868.5700578213824;972.2610815780058;1042.4839704346398;1078.9190810689072;1079.4171147580219;26505.734942650328;27814;28115.859420703175;28245.858770706014;28350.43299134047;994.005994005994;1017.6896046705677;1028.4189432970347;1058.2433560004633;1078.6710053433621;13546.390412431267;13842.93078534621;14853.48012819546;14878.256087195814;15065.774013389808;568438;580408;587266;588698;589045;58175.70912145412;58589;59025.11462327983;59032.40967590355;59066.70466647639;1350.1494058742928;1389;1395.2605119286795;1409.4925826702583;1414.5473448496382;25498.872505638094;25660.871695641403;26373;26759.464810704067;26825.195244142706;51139.488605113474;52177.21734174067;52290.47709523008;52388.73805630948;52493.475065250386;478957.4729769022;479857;479975;480041;480496;28566.285842853264;28751.424971500033;29171.85414073001;29204.853975730835;29276.707232927398;39506.60493395144;40265.79867100646;40316.39525407062;40332.39501407422;40497.39253911252;35083.473747893295;35912.640873591976;36348.27303453969;36555.634443655224;36726.816365918;40615.18769624532;40644.39033414442;41476.58523414727;42896.35655465233;44800.77599611981;31854;35587;35784;36084;36970.8151459241;35009.474857876645;36833;37613.435798462495;37702.811485942395;38207;24713.505729884942;24981.625275621245;25028.749712502642;25190.874045629655;25238.873805630854 16:40:20 INFO - PROCESS | 15834 | |2;jquery.html;388.37083924043037;391.4031102568581;410.1264307026035;410.8500397354965;424.89165262857966;13928.791068133985;17494.65010699787;19103.52241193969;19139.33012344568;19646.312379066734;18951.52621184471;19339.4198174055;19525.41423757286;20124.39626811198;20251.898740506276;5809.186713860063;5825.1844741736195;5971.343152253248;6054.878902421949;6064.151018857364;6110.725017374229;6117.602355846878;6128.295246046695;6153.907691384633;6155;6188.319284878659;6671.899921501182;6674.899876501856;6715.8656826863435;6721.798346049626;6493.090967264587;6607.966960165217;6624.536282460205;6665.800025999228;6705.295943925891;5960.284765828085;5983.252093488314;5990.071538911476;5991.910121348184;5996.070609055603;14540.563783086523;14964.326605302787;23333.716645584485;24226.757732422626;25180.370490737696;2341.1688850458013;2487.8009759219217;2870.5550639650887;2959.4377068356944;3042.908712738599;10001.299909006373;10736.30214036093;10916.07213386863;11161.107111431065;14161.716765664733;1957.354073155855;2031.7460317460318;2044.4377796106041;2058.835293176542;2059.1145807302855;84960.57519712424;85075;85166.57416712877;86501;86986.13013869844;11087.168462365355;11156.16328775345;11359.716007099723;11365.261258018203;11472.77054458906;15908.68182636364;15933;15937.760933586005;15948.288790905573;15948.601284967968;7559.1684914659345;7704.768856934301;7897.802554936173;8039.437239393304;8075.919240807634;7229.120428688579;7273.927260727431;7329.510796632914;7526.247375262539;7529.117720569858;4726.409198850144;4772.308015337757;4854.368932038812;4891.1685013547785;5003.174476211457;2010.4069299556666;2027.3613811649284;2048.7848775878615;2077.4494758888904;2094.172801743303;819.5246756880995;873.5850471026339;893.718478679214;904.5793705926644;982.0474140084107;15595.298211580506;16077.598060048593;16113.436029738903;16255.10596917181;16650.58373540671;880.8854848869734;885.4333226734894;901.1124042817819;913.9405938613969;927.1609193679731;8985.146411090936;9598.760030999281;9616.807663846685;9635.855462168072;9688.41869487833;345830;453717;458349;504240;514262;95128;95664;96677.51661241648;99776;100125;1005.1305620638242;1021.1371391174595;1050.406520316019;1054.9367037977745;1057.0644979193316;15597.117449547784;15827.287772050055;15832.92083539575;16793;16949.66100677955;43450.34824477572;44280.557194427645;44473.11053778971;44676.55323446724;45561.544384557055;58520.414795851495;60632.69683651553;61528.07707884475;61673.38326616856;61677.69161154165;6600.174978127734;8441.662333506836;8730.519821409884;8984.216916228206;9329.393589416666;9828.110412724871;13167.2757998311;13659.317034148451;13770.104943178661;13872.306384680927;10751;11223.887761122285;11235.66293011211;11442.199046067028;11454.370009649549;11387.259828111146;11504.482298296763;11719.589814356457;11723.531058757895;11751.529938802352;11137.610183643534;11388.715282118013;11475.770484590428;11478.450409194651;11840.230385024946;7541.208173141741;7936.127026027248;8840.160184782435;8892.421992570462;9071.773205669911;11034.944825275823;11340.149488788209;11410.885891140982;11573.189876708886;11627.302361858316 16:40:20 INFO - PROCESS | 15834 | |3;mootools.html;1518.3243456661783;1528.9770653440198;1683.1920678074523;1745.5199820049493;1826.3242600237913;7771.378289736822;8608.440451370656;8699.130086991298;9263.814723705522;9339.34624576279;8781.165789250026;9027.232685221765;9141.177294043535;9141.954290228556;9169.31230157739;2349.5535848188833;2353.364591560278;2369.1944738788807;2393.6768536247646;2394.784469397754;2326.3021093671914;2362.503874186414;2370.4073981504625;2390.1395497620842;2391.1272385579227;2372.418757404438;2390.079819269585;2392.3301475586777;2397.880105994693;2399.7720216579396;2280.6579013147993;2282.281081459335;2285.6571514272828;2291.1179196009575;2344.10923848938;2291.713535808024;2302.412884714404;2304.2280835919987;2308.803751681109;2311.6879221305076;8784.121587841164;9001.414908030956;9011.098890111001;9035.32235082365;9039.819203615956;5177.637565370425;5212.635115541913;5259.474052594748;5274.2879711238875;5276.182191760283;3193.505006723938;3356.848941797625;3413.453847384407;3429.4684323929832;3454.240067185215;1150.223599070624;1193.4331192683492;1220.1580909172642;1222.1628184693514;1234.370471059757;12126.333051682153;12195.634130976085;12235.877641223562;12280.38598070102;12303.630891073193;4452.465704115462;4557.134144512598;4725.834595789131;4729.408823897013;4783.617310615143;10215.846762298572;10290;10306.896931030593;10308.587656493657;10312.690619281433;5280.6039547034125;5296.073187192226;5318.840434786963;5318.8936221276135;5325.094733895247;4194.328907374806;4607.3319368691355;4716.410448693913;4776.188048031843;4888.853334399973;4021.939670904939;4103.322951712934;4146.232946904832;4174.998000479863;4199.223143718422;1304.4651692805903;1344.8722371374704;1355.6339788257312;1364.3519328318969;1368.5825823124044;779.5089093870826;832.5296207642783;866.7226487523932;896.7982204004047;920.0063930954553;5404.594655400861;5444.455554444524;5461.590380721462;5479.616426850162;5570.777168913198;463.2981033733896;479.8968221832323;482.13216210820383;487.4954422173034;487.8731529802277;3550.715942724576;3676.981615091961;3730.4963829883163;3746.138388170736;3805.1438426354403;10989;11131.443427828575;11133.554657813758;11199.888001120047;11324.207305488537;11285.887141128647;11307.321560706385;11310.83033754478;11313.094952403788;11327.433628318551;7930.484518506279;8051.5169089853625;8128.674853005932;8228.50628962264;8380.790480238044;5548.361938377138;5830.883382332415;5915.792947246998;5941.257342832146;6055.303640081447;9811;10182.18542516582;10188.592456301962;10370.948145259226;10376.236039873089;10223.846642300223;10274.22943279272;10401.427921464392;10498.737531561772;10595.417252050904;7307.890381644386;8141.104478507478;8197.83604327922;8203.58982050907;8479.109693482096;8424.410291279797;8453.91546084556;8487.660493580435;8499.57502124879;8506.319494440553;7621.618919053914;7642.465027448247;7766.068071831416;7827.45207835446;7856.332211762065;7557.5465472071855;7602.923970760222;7627.237276272328;7658.119316278699;7750.379969602531;6450.645214513247;6528.053432252392;6528.575642583217;6543.836404089745;6557.147570815954;4915.778789954532;4972.776225069808;4979.253112033224;5018.5232402921665;5137.691738495702;4929.038837426668;4972;4980;5081.11080560893;5085 16:40:20 INFO - PROCESS | 15834 | |4;prototype.html;325.79312136793146;333.6746671994804;335.71631970984515;339.75198105383083;342.93312804003216;5296.5434505511;5354.759035843386;5543.528800051995;5638.8026419075395;5643.25059231638;5410.215518749779;5469.343678758554;5492.176173573966;5494.0934745767;5528.170774383844;4313;4332.458442694663;4340.913181736363;4341.739495630272;4343.435353404053;4209.85297498275;4283.742975421469;4324.416203812477;4365.279728844736;4375.562443755615;4231.830726770925;4261.659067274611;4271.722338048017;4287.7856107194675;4292.463442069741;4288.76411797351;4293.65650747941;4323.286657701507;4336.56634336567;4341.111616446824;3483.303339332144;3824.7131465140224;3834.7183425861845;3837.808109594509;3845.1156234066043;5274.208868669692;5299.470052994709;5329.840104796862;5336.946630533684;5340.652857564246;4753.714777113384;4807.158747219222;4814.277858321279;4819.421669399694;4820.638452116105;5517.751701173457;5664.688442135681;5669.092945128801;5672.773089076432;5713.657180569179;4065.7763822989723;4070.450489183952;4077.796110194508;4107.260693075245;4120.299549076664;5983.730732117066;5988.461038506555;6000.489958353545;6006;6021.909671354933;4067.51189857219;4191.937120943188;4222.218889505451;4237.406763053175;4253.893652658647;4213.272558251102;4224.134052519226;4226.964393723558;4233.026403927114;4235.174141042467;4865.294532292798;4889.633277504201;4891.2174052152195;4902.583280421133;4908.8772780680765;5683.460071293221;5759.8560035999435;5780.988327042751;5809.779946211258;5821.457313811843;1448.9782653260208;1467.2736995187238;1469.280052774133;1472.580314610331;1474.7198032374029;909.3679892474798;939.4316438554713;942.3733217410345;951.6478902805868;952.9809403812023;4760.785764640599;4774.474807771142;4826.7827947742435;4850.587700045465;4883.4139903211135;5187.610929180251;5198.518422249641;5208.557272631869;5234.502722241381;5238.68567885928;4687.882802929954;4899.971006088761;4915.90168196634;4942.703437793672;4947.752612369367;2730.645016147928;2734.4941185880675;2738.561830107173;2752.628395166627;2757.9586306205424;5289.285946397187;5305.798093791033;5310.654807437581;5382.219578161144;5401.783928642811;5077.568406685399;5095.8980820383385;5234.586661601346;5250.159974404077;5262.447443018505;5320.989012087691;5344.4922732340365;5358.66897899415;5369.758360873692;5383.67697938125;5141.794328226829;5170.5346518813485;5201.7399130044105;5209.374875014871;5237.502437268454;4855.830045948375;5054.747262636927;5139.434662187082;5147.6911385317;5178.4366738463195;5423.430539793423;5439.374471935778;5443.237946687546;5449.719315960825;5489.560835133259;3787.958311464369;3806.707198273529;4120.743173332163;4310.655147588122;4310.655147588248;5770.769169233184;5798.478136967693;5830.795922142875;5852.18069470266;5858.3596592954045;5512.283403157564;5700.344460386943;5724.570657200643;5773.566982476415;5781.190633311424;5661.405552416937;5682.005649011489;5683.460071293221;5683.5453163747625;5713.514351280021;5662.8018019370775;5702.800401985911;5746.023176060164;5775.797847075332;5790.710464476843;5520.834374968757;5726.4273572642405;5761.02062649359;5775.826725198251;5779.8555036124435;5635.915461268002;5647.5481961442165;5670.404607516151;5713.857153571194;5716.857078573069 16:40:20 INFO - PROCESS | 15834 | |5;yui.html;668.5320275806935;716.6345163966379;732.406750532069;751.6730222353277;755;16251.918740406296;17630.735538966925;17697.734533981984;17757.55606109848;17804.020778857175;14229.928850355735;14514.854851451482;14652.560423187295;16005.27976241069;16016.59958501038;805.4200975297791;823.0329362998483;825.4263287015526;825.9587020648974;826.3017750001239;802.6227672993713;822.9341652667772;823.4277177361736;826.8470332988386;829.6308142876422;866.0906048648925;867.4101610904582;868.513632365874;871.0723079919865;873.1268731268731;859.9656013759442;863.7926897544606;864.7621903976425;865.0527672198932;866.1684782608703;626.0171530696808;632.4497687012283;633.733831790649;634.0900807341434;634.43852190811;16884.240209190615;17016;17063.14684265794;17090.401835935805;17103.914480427517;14892.62768430798;14893.627659308604;15265.313060912285;15403;15602.531924042183;12285.38573071343;12413.937930310381;12443.813342799865;12684.112112152154;12782.87217127826;3912.726109172359;3997.1006523532265;3998.8800335989968;4063.065494936181;4152;90149;90985.54507227488;92691;93229.53385233098;93806.5309673454;11681.299122052704;12218.755624887452;12239.938800305941;12243.265404075784;12530.310832904277;22850.20024299175;22861.542769144526;22903.427414314774;22925.770742292698;22932.4266893329;8045.316148127475;8191.549464779375;8453.154684531497;8586.441881277697;8704.303655707528;4903.607711383081;5000.993838203155;5019.623528235397;5051.318072060299;5057.21613149955;3526.153723106436;3635.345637785171;3654.616265292106;3655.6161603031833;3662.102784817737;555.5444535480948;562.061357532921;575.2722805650855;578.8408187748403;581.2588949089944;673.5621845800171;717.5515302935665;727.7816655003478;756.1266736918867;778.381186956371;9507.15736292043;10060.699987084998;10061.791659618597;10139.898601014043;10233.795324093626;705.5766540075913;719.4064896460441;733.1202556931703;738.5605564689001;768.9346405555591;4612.86161415158;4856.2958371036;4882.658213925062;4893;4976.925346119811;103980;119907.40046299713;123223;125580;132426;65806.34193658098;69138;102183;109800.66694331072;113843.43078284555;56528.99999999918;59121.40878591245;80312.19687803047;83179.6025496813;92613.5369323149;9770.071843174886;10238.283320167517;10273.434961076913;10362;10401.479926003822;49246.50753492419;51419.82962044579;52583.211251830486;53931.73034134804;54739.978602352916;72757;75298.24701752912;81655;82418;83098;12474.563390281297;12585.24488530691;12590.874091258971;12773.936130319289;13108.475660973836;14750.926245369134;15130;15346.539603811903;15607.141607211712;15845;13226.603201903958;14080.929595351958;14300.570982870531;14433.35049922777;14737.336819843347;13582.185068895898;13954.790678139632;14028;14287.285635718381;14435.278236087943;13444.731105378034;14046.367913444124;14214.147151170962;14306.57080287593;14900.105993640416;10317.17462602975;10656.786864262827;10852.674419767103;10889.237753357505;10955.50700218476;10945.945270273916;11341.716457088309;11401.144914131639;11479.25384849982;11501.424928753697 16:40:20 INFO - PROCESS | 15834 | __end_tp_report 16:40:20 INFO - PROCESS | 15834 | __start_cc_report 16:40:20 INFO - PROCESS | 15834 | _x_x_mozilla_cycle_collect,307 16:40:20 INFO - PROCESS | 15834 | __end_cc_report 16:40:20 INFO - PROCESS | 15834 | __startTimestamp1471390820281__endTimestamp 16:40:20 INFO - PROCESS | 15834 | 16:40:20 INFO - PROCESS | 15834 | ------- Summary: start ------- 16:40:20 INFO - PROCESS | 15834 | Number of tests: 6 16:40:20 INFO - PROCESS | 15834 | 16:40:20 INFO - PROCESS | 15834 | [#0] dojo.html Cycles:165 Average:5528.73 Median:5739.40 stddev:661.42 (11.5%) stddev-sans-first:635.50 16:40:20 INFO - PROCESS | 15834 | Values: 3103.8 3127.3 3144.0 3154.4 3164.5 5380.4 5550.7 5568.5 5659.9 5700.0 5556.6 5561.7 5589.0 5615.7 5644.0 4981.5 5070.9 5082.1 5123.1 5194.6 5147.4 5151.1 5155.2 5200.3 5220.3 4913.0 4963.2 5017.9 5091.4 5106.6 5054.7 5062.8 5078.5 5111.4 5122.9 4988.4 5038.4 5044.4 5062.1 5080.8 5358.3 5433.8 5507.1 5514.7 5544.7 5930.2 5936.7 5944.2 5976.9 5988.6 5972.9 5991.2 5997.9 6000.4 6002.9 5285.3 5486.0 5525.6 5546.8 5569.0 6129.5 6137.9 6146.2 6150.2 6157.2 5875.9 5905.0 5916.0 5922.5 5943.5 5750.8 5889.7 5931.8 5940.8 5999.7 5960.4 5965.0 5966.5 5976.0 6003.6 5938.2 5956.8 5962.4 5964.3 5969.2 4287.0 4395.5 4427.3 4428.4 4435.5 3963.8 3968.4 3991.0 3997.1 4016.8 5566.3 5636.6 5638.7 5650.9 5652.6 5743.4 5898.8 5940.1 6053.6 6070.6 5644.5 5647.0 5659.7 5663.1 5674.6 4971.9 4976.5 4978.5 4995.8 5014.3 5815.8 6069.4 6130.2 6150.3 6166.7 6036.3 6042.9 6047.2 6069.5 6088.7 6213.9 6243.7 6252.3 6266.6 6274.5 5700.9 5739.4 5885.9 5925.8 5954.7 5989.5 6008.5 6035.4 6053.5 6064.6 5874.8 5880.2 5885.1 5886.4 5908.6 5551.8 5771.0 5778.2 5788.1 5882.1 5840.5 5888.7 5892.8 5894.6 5934.3 5853.5 5864.3 5911.4 5915.1 5924.9 5522.0 5678.2 5696.3 5716.0 5731.6 16:40:20 INFO - PROCESS | 15834 | 16:40:20 INFO - PROCESS | 15834 | [#1] ext.html Cycles:180 Average:59570.88 Median:37658.12 stddev:125949.02 (334.5%) stddev-sans-first:126224.38 16:40:20 INFO - PROCESS | 15834 | Values: 545.1 591.0 592.7 609.8 623.0 36714.3 40807.6 41075.2 41287.8 41358.2 43584.8 44075.8 44079.3 44161.8 44165.6 8879.8 8971.3 9044.7 9045.8 9055.4 8870.2 8940.4 8954.3 8975.6 8983.7 8936.4 8979.6 9048.8 9049.8 9057.2 8960.2 9012.7 9020.3 9020.8 9029.2 8888.6 8915.0 8954.4 8956.7 8960.7 42684.6 42866.8 42909.8 43136.0 43395.6 2514.5 3131.1 3366.4 3446.3 3488.9 31586.0 32359.5 32518.3 32631.2 32668.3 4064.4 4069.9 4128.9 4129.2 4302.3 312174.0 313219.0 314663.0 315334.0 315768.0 34933.8 35249.5 35481.3 35509.6 35693.6 36379.0 36439.6 36494.0 36515.6 36588.8 15907.2 16698.7 16716.7 16726.5 16894.4 12640.4 12784.7 12785.7 12792.9 12814.0 19077.9 19110.2 19125.7 19286.0 19294.2 7246.7 7261.9 7309.6 7345.6 7492.4 868.6 972.3 1042.5 1078.9 1079.4 26505.7 27814.0 28115.9 28245.9 28350.4 994.0 1017.7 1028.4 1058.2 1078.7 13546.4 13842.9 14853.5 14878.3 15065.8 568438.0 580408.0 587266.0 588698.0 589045.0 58175.7 58589.0 59025.1 59032.4 59066.7 1350.1 1389.0 1395.3 1409.5 1414.5 25498.9 25660.9 26373.0 26759.5 26825.2 51139.5 52177.2 52290.5 52388.7 52493.5 478957.5 479857.0 479975.0 480041.0 480496.0 28566.3 28751.4 29171.9 29204.9 29276.7 39506.6 40265.8 40316.4 40332.4 40497.4 35083.5 35912.6 36348.3 36555.6 36726.8 40615.2 40644.4 41476.6 42896.4 44800.8 31854.0 35587.0 35784.0 36084.0 36970.8 35009.5 36833.0 37613.4 37702.8 38207.0 24713.5 24981.6 25028.7 25190.9 25238.9 16:40:20 INFO - PROCESS | 15834 | 16:40:20 INFO - PROCESS | 15834 | [#2] jquery.html Cycles:180 Average:28307.01 Median:21937.62 stddev:76225.07 (347.5%) stddev-sans-first:76410.07 16:40:20 INFO - PROCESS | 15834 | Values: 388.4 391.4 410.1 410.9 424.9 13928.8 17494.7 19103.5 19139.3 19646.3 18951.5 19339.4 19525.4 20124.4 20251.9 5809.2 5825.2 5971.3 6054.9 6064.2 6110.7 6117.6 6128.3 6153.9 6155.0 6188.3 6671.9 6674.9 6715.9 6721.8 6493.1 6608.0 6624.5 6665.8 6705.3 5960.3 5983.3 5990.1 5991.9 5996.1 14540.6 14964.3 23333.7 24226.8 25180.4 2341.2 2487.8 2870.6 2959.4 3042.9 10001.3 10736.3 10916.1 11161.1 14161.7 1957.4 2031.7 2044.4 2058.8 2059.1 84960.6 85075.0 85166.6 86501.0 86986.1 11087.2 11156.2 11359.7 11365.3 11472.8 15908.7 15933.0 15937.8 15948.3 15948.6 7559.2 7704.8 7897.8 8039.4 8075.9 7229.1 7273.9 7329.5 7526.2 7529.1 4726.4 4772.3 4854.4 4891.2 5003.2 2010.4 2027.4 2048.8 2077.4 2094.2 819.5 873.6 893.7 904.6 982.0 15595.3 16077.6 16113.4 16255.1 16650.6 880.9 885.4 901.1 913.9 927.2 8985.1 9598.8 9616.8 9635.9 9688.4 345830.0 453717.0 458349.0 504240.0 514262.0 95128.0 95664.0 96677.5 99776.0 100125.0 1005.1 1021.1 1050.4 1054.9 1057.1 15597.1 15827.3 15832.9 16793.0 16949.7 43450.3 44280.6 44473.1 44676.6 45561.5 58520.4 60632.7 61528.1 61673.4 61677.7 6600.2 8441.7 8730.5 8984.2 9329.4 9828.1 13167.3 13659.3 13770.1 13872.3 10751.0 11223.9 11235.7 11442.2 11454.4 11387.3 11504.5 11719.6 11723.5 11751.5 11137.6 11388.7 11475.8 11478.5 11840.2 7541.2 7936.1 8840.2 8892.4 9071.8 11034.9 11340.1 11410.9 11573.2 11627.3 16:40:20 INFO - PROCESS | 15834 | 16:40:20 INFO - PROCESS | 15834 | [#3] mootools.html Cycles:180 Average:5793.81 Median:4727.62 stddev:3361.50 (71.1%) stddev-sans-first:3355.58 16:40:20 INFO - PROCESS | 15834 | Values: 1518.3 1529.0 1683.2 1745.5 1826.3 7771.4 8608.4 8699.1 9263.8 9339.3 8781.2 9027.2 9141.2 9142.0 9169.3 2349.6 2353.4 2369.2 2393.7 2394.8 2326.3 2362.5 2370.4 2390.1 2391.1 2372.4 2390.1 2392.3 2397.9 2399.8 2280.7 2282.3 2285.7 2291.1 2344.1 2291.7 2302.4 2304.2 2308.8 2311.7 8784.1 9001.4 9011.1 9035.3 9039.8 5177.6 5212.6 5259.5 5274.3 5276.2 3193.5 3356.8 3413.5 3429.5 3454.2 1150.2 1193.4 1220.2 1222.2 1234.4 12126.3 12195.6 12235.9 12280.4 12303.6 4452.5 4557.1 4725.8 4729.4 4783.6 10215.8 10290.0 10306.9 10308.6 10312.7 5280.6 5296.1 5318.8 5318.9 5325.1 4194.3 4607.3 4716.4 4776.2 4888.9 4021.9 4103.3 4146.2 4175.0 4199.2 1304.5 1344.9 1355.6 1364.4 1368.6 779.5 832.5 866.7 896.8 920.0 5404.6 5444.5 5461.6 5479.6 5570.8 463.3 479.9 482.1 487.5 487.9 3550.7 3677.0 3730.5 3746.1 3805.1 10989.0 11131.4 11133.6 11199.9 11324.2 11285.9 11307.3 11310.8 11313.1 11327.4 7930.5 8051.5 8128.7 8228.5 8380.8 5548.4 5830.9 5915.8 5941.3 6055.3 9811.0 10182.2 10188.6 10370.9 10376.2 10223.8 10274.2 10401.4 10498.7 10595.4 7307.9 8141.1 8197.8 8203.6 8479.1 8424.4 8453.9 8487.7 8499.6 8506.3 7621.6 7642.5 7766.1 7827.5 7856.3 7557.5 7602.9 7627.2 7658.1 7750.4 6450.6 6528.1 6528.6 6543.8 6557.1 4915.8 4972.8 4979.3 5018.5 5137.7 4929.0 4972.0 4980.0 5081.1 5085.0 16:40:20 INFO - PROCESS | 15834 | 16:40:20 INFO - PROCESS | 15834 | [#4] prototype.html Cycles:180 Average:4647.17 Median:5200.13 stddev:1340.20 (25.8%) stddev-sans-first:1304.12 16:40:20 INFO - PROCESS | 15834 | Values: 325.8 333.7 335.7 339.8 342.9 5296.5 5354.8 5543.5 5638.8 5643.3 5410.2 5469.3 5492.2 5494.1 5528.2 4313.0 4332.5 4340.9 4341.7 4343.4 4209.9 4283.7 4324.4 4365.3 4375.6 4231.8 4261.7 4271.7 4287.8 4292.5 4288.8 4293.7 4323.3 4336.6 4341.1 3483.3 3824.7 3834.7 3837.8 3845.1 5274.2 5299.5 5329.8 5336.9 5340.7 4753.7 4807.2 4814.3 4819.4 4820.6 5517.8 5664.7 5669.1 5672.8 5713.7 4065.8 4070.5 4077.8 4107.3 4120.3 5983.7 5988.5 6000.5 6006.0 6021.9 4067.5 4191.9 4222.2 4237.4 4253.9 4213.3 4224.1 4227.0 4233.0 4235.2 4865.3 4889.6 4891.2 4902.6 4908.9 5683.5 5759.9 5781.0 5809.8 5821.5 1449.0 1467.3 1469.3 1472.6 1474.7 909.4 939.4 942.4 951.6 953.0 4760.8 4774.5 4826.8 4850.6 4883.4 5187.6 5198.5 5208.6 5234.5 5238.7 4687.9 4900.0 4915.9 4942.7 4947.8 2730.6 2734.5 2738.6 2752.6 2758.0 5289.3 5305.8 5310.7 5382.2 5401.8 5077.6 5095.9 5234.6 5250.2 5262.4 5321.0 5344.5 5358.7 5369.8 5383.7 5141.8 5170.5 5201.7 5209.4 5237.5 4855.8 5054.7 5139.4 5147.7 5178.4 5423.4 5439.4 5443.2 5449.7 5489.6 3788.0 3806.7 4120.7 4310.7 4310.7 5770.8 5798.5 5830.8 5852.2 5858.4 5512.3 5700.3 5724.6 5773.6 5781.2 5661.4 5682.0 5683.5 5683.5 5713.5 5662.8 5702.8 5746.0 5775.8 5790.7 5520.8 5726.4 5761.0 5775.8 5779.9 5635.9 5647.5 5670.4 5713.9 5716.9 16:40:20 INFO - PROCESS | 15834 | 16:40:20 INFO - PROCESS | 15834 | [#5] yui.html Cycles:180 Average:21357.41 Median:3787.41 stddev:30794.45 (813.1%) stddev-sans-first:30841.65 16:40:20 INFO - PROCESS | 15834 | Values: 668.5 716.6 732.4 751.7 755.0 16251.9 17630.7 17697.7 17757.6 17804.0 14229.9 14514.9 14652.6 16005.3 16016.6 805.4 823.0 825.4 826.0 826.3 802.6 822.9 823.4 826.8 829.6 866.1 867.4 868.5 871.1 873.1 860.0 863.8 864.8 865.1 866.2 626.0 632.4 633.7 634.1 634.4 16884.2 17016.0 17063.1 17090.4 17103.9 14892.6 14893.6 15265.3 15403.0 15602.5 12285.4 12413.9 12443.8 12684.1 12782.9 3912.7 3997.1 3998.9 4063.1 4152.0 90149.0 90985.5 92691.0 93229.5 93806.5 11681.3 12218.8 12239.9 12243.3 12530.3 22850.2 22861.5 22903.4 22925.8 22932.4 8045.3 8191.5 8453.2 8586.4 8704.3 4903.6 5001.0 5019.6 5051.3 5057.2 3526.2 3635.3 3654.6 3655.6 3662.1 555.5 562.1 575.3 578.8 581.3 673.6 717.6 727.8 756.1 778.4 9507.2 10060.7 10061.8 10139.9 10233.8 705.6 719.4 733.1 738.6 768.9 4612.9 4856.3 4882.7 4893.0 4976.9 103980.0 119907.4 123223.0 125580.0 132426.0 65806.3 69138.0 102183.0 109800.7 113843.4 56529.0 59121.4 80312.2 83179.6 92613.5 9770.1 10238.3 10273.4 10362.0 10401.5 49246.5 51419.8 52583.2 53931.7 54740.0 72757.0 75298.2 81655.0 82418.0 83098.0 12474.6 12585.2 12590.9 12773.9 13108.5 14750.9 15130.0 15346.5 15607.1 15845.0 13226.6 14080.9 14300.6 14433.4 14737.3 13582.2 13954.8 14028.0 14287.3 14435.3 13444.7 14046.4 14214.1 14306.6 14900.1 10317.2 10656.8 10852.7 10889.2 10955.5 10945.9 11341.7 11401.1 11479.3 11501.4 16:40:20 INFO - PROCESS | 15834 | -------- Summary: end -------- 16:40:20 INFO - PROCESS | 15834 | 16:40:21 INFO - TEST-INFO | 15834: exit 0 16:40:21 INFO - TEST-OK | dromaeo_css | took 1113535ms 16:40:21 INFO - TEST-START | kraken 16:40:21 INFO - operating with platform_type : linux_ 16:40:21 INFO - Initialising browser for kraken test... 16:40:21 INFO - TEST-INFO | started process 16194 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfu2Qug/profile http://localhost:58824/getInfo.html) 16:40:25 INFO - PROCESS | 16194 | __metrics Screen width/height:1600/1200 16:40:25 INFO - PROCESS | 16194 | colorDepth:24 16:40:25 INFO - PROCESS | 16194 | Browser inner width/height: 1024/697 16:40:25 INFO - PROCESS | 16194 | __metrics 16:40:26 ERROR - PROCESS | 16194 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 16:40:27 INFO - TEST-INFO | 16194: exit 0 16:40:27 INFO - Browser initialized. 16:40:27 INFO - Running cycle 1/1 for kraken test... 16:40:27 INFO - TEST-INFO | started process 16314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfu2Qug/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:40:38 INFO - PROCESS | 16314 | RSS: Main: 163028992 16:40:38 INFO - PROCESS | 16314 | 16:40:41 INFO - PROCESS | 16314 | Cycle 1(1): loaded http://localhost:58824/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58824/tests/kraken/driver.html?testName=audio-beat-detection) 16:40:42 INFO - PROCESS | 16314 | RSS: Main: 168316928 16:40:42 INFO - PROCESS | 16314 | 16:40:44 INFO - PROCESS | 16314 | Cycle 1(1): loaded http://localhost:58824/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58824/tests/kraken/driver.html?testName=audio-dft) 16:40:45 INFO - PROCESS | 16314 | RSS: Main: 167378944 16:40:45 INFO - PROCESS | 16314 | 16:40:48 INFO - PROCESS | 16314 | Cycle 1(1): loaded http://localhost:58824/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58824/tests/kraken/driver.html?testName=audio-fft) 16:40:49 INFO - PROCESS | 16314 | RSS: Main: 162705408 16:40:49 INFO - PROCESS | 16314 | 16:40:51 INFO - PROCESS | 16314 | Cycle 1(1): loaded http://localhost:58824/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58824/tests/kraken/driver.html?testName=audio-oscillator) 16:40:51 INFO - PROCESS | 16314 | RSS: Main: 163909632 16:40:51 INFO - PROCESS | 16314 | 16:40:54 INFO - PROCESS | 16314 | Cycle 1(1): loaded http://localhost:58824/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58824/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:40:54 INFO - PROCESS | 16314 | RSS: Main: 164335616 16:40:54 INFO - PROCESS | 16314 | 16:40:57 INFO - PROCESS | 16314 | Cycle 1(1): loaded http://localhost:58824/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58824/tests/kraken/driver.html?testName=imaging-darkroom) 16:40:58 INFO - PROCESS | 16314 | RSS: Main: 164769792 16:40:58 INFO - PROCESS | 16314 | 16:41:01 INFO - PROCESS | 16314 | Cycle 1(1): loaded http://localhost:58824/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58824/tests/kraken/driver.html?testName=imaging-desaturate) 16:41:02 INFO - PROCESS | 16314 | RSS: Main: 162254848 16:41:02 INFO - PROCESS | 16314 | 16:41:05 INFO - PROCESS | 16314 | Cycle 1(1): loaded http://localhost:58824/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58824/tests/kraken/driver.html?testName=json-parse-financial) 16:41:06 INFO - PROCESS | 16314 | RSS: Main: 163942400 16:41:06 INFO - PROCESS | 16314 | 16:41:07 INFO - PROCESS | 16314 | Cycle 1(1): loaded http://localhost:58824/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58824/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:41:08 INFO - PROCESS | 16314 | RSS: Main: 164069376 16:41:08 INFO - PROCESS | 16314 | 16:41:09 INFO - PROCESS | 16314 | Cycle 1(1): loaded http://localhost:58824/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58824/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:41:10 INFO - PROCESS | 16314 | RSS: Main: 164151296 16:41:10 INFO - PROCESS | 16314 | 16:41:12 INFO - PROCESS | 16314 | Cycle 1(1): loaded http://localhost:58824/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58824/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:41:13 INFO - PROCESS | 16314 | RSS: Main: 164765696 16:41:13 INFO - PROCESS | 16314 | 16:41:16 INFO - PROCESS | 16314 | Cycle 1(1): loaded http://localhost:58824/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58824/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:41:16 INFO - PROCESS | 16314 | RSS: Main: 164749312 16:41:16 INFO - PROCESS | 16314 | 16:41:19 INFO - PROCESS | 16314 | Cycle 1(1): loaded http://localhost:58824/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58824/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:41:20 INFO - PROCESS | 16314 | RSS: Main: 165011456 16:41:20 INFO - PROCESS | 16314 | 16:41:21 INFO - PROCESS | 16314 | Cycle 1(1): loaded http://localhost:58824/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58824/tests/kraken/driver.html?testName=ai-astar) 16:41:22 INFO - PROCESS | 16314 | RSS: Main: 165781504 16:41:22 INFO - PROCESS | 16314 | 16:41:22 INFO - PROCESS | 16314 | __start_tp_report 16:41:22 INFO - PROCESS | 16314 | _x_x_mozilla_page_load 16:41:22 INFO - PROCESS | 16314 | _x_x_mozilla_page_load_details 16:41:22 INFO - PROCESS | 16314 | |i|pagename|runs| 16:41:22 INFO - PROCESS | 16314 | |0;ai-astar;103;111;109;113;112;112;117;111;113;112 16:41:22 INFO - PROCESS | 16314 | |1;audio-beat-detection;143;117;152;193;124;148;152;125;182;121 16:41:22 INFO - PROCESS | 16314 | |2;audio-dft;164;164;163;165;163;169;170;162;161;161 16:41:22 INFO - PROCESS | 16314 | |3;audio-fft;75;76;75;183;76;76;76;79;178;75 16:41:22 INFO - PROCESS | 16314 | |4;audio-oscillator;87;85;153;86;84;85;144;89;85;159 16:41:22 INFO - PROCESS | 16314 | |5;imaging-gaussian-blur;118;117;117;118;118;118;118;118;118;118 16:41:22 INFO - PROCESS | 16314 | |6;imaging-darkroom;148;147;146;147;147;148;147;147;150;148 16:41:22 INFO - PROCESS | 16314 | |7;imaging-desaturate;97;96;95;95;96;96;95;96;96;95 16:41:22 INFO - PROCESS | 16314 | |8;json-parse-financial;52;52;56;52;53;56;52;58;53;56 16:41:22 INFO - PROCESS | 16314 | |9;json-stringify-tinderbox;62;62;67;63;62;62;61;62;62;63 16:41:22 INFO - PROCESS | 16314 | |10;stanford-crypto-aes;90;85;89;81;79;80;83;86;86;79 16:41:22 INFO - PROCESS | 16314 | |11;stanford-crypto-ccm;127;126;124;125;139;130;123;129;138;137 16:41:22 INFO - PROCESS | 16314 | |12;stanford-crypto-pbkdf2;169;163;163;161;162;160;161;166;164;165 16:41:22 INFO - PROCESS | 16314 | |13;stanford-crypto-sha256-iterative;65;66;68;65;63;64;66;68;71;63 16:41:22 INFO - PROCESS | 16314 | __end_tp_report 16:41:22 INFO - PROCESS | 16314 | __start_cc_report 16:41:22 INFO - PROCESS | 16314 | _x_x_mozilla_cycle_collect,819 16:41:22 INFO - PROCESS | 16314 | __end_cc_report 16:41:22 INFO - PROCESS | 16314 | __startTimestamp1471390882077__endTimestamp 16:41:22 INFO - PROCESS | 16314 | 16:41:22 INFO - PROCESS | 16314 | ------- Summary: start ------- 16:41:22 INFO - PROCESS | 16314 | Number of tests: 14 16:41:22 INFO - PROCESS | 16314 | 16:41:22 INFO - PROCESS | 16314 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:3.56 (3.2%) stddev-sans-first:2.17 16:41:22 INFO - PROCESS | 16314 | Values: 103.0 111.0 109.0 113.0 112.0 112.0 117.0 111.0 113.0 112.0 16:41:22 INFO - PROCESS | 16314 | 16:41:22 INFO - PROCESS | 16314 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:150.00 stddev:25.78 (17.2%) stddev-sans-first:27.32 16:41:22 INFO - PROCESS | 16314 | Values: 143.0 117.0 152.0 193.0 124.0 148.0 152.0 125.0 182.0 121.0 16:41:22 INFO - PROCESS | 16314 | 16:41:22 INFO - PROCESS | 16314 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:3.08 (1.9%) stddev-sans-first:3.27 16:41:22 INFO - PROCESS | 16314 | Values: 164.0 164.0 163.0 165.0 163.0 169.0 170.0 162.0 161.0 161.0 16:41:22 INFO - PROCESS | 16314 | 16:41:22 INFO - PROCESS | 16314 | [#3] audio-fft Cycles:10 Average:96.90 Median:76.00 stddev:44.09 (58.0%) stddev-sans-first:46.05 16:41:22 INFO - PROCESS | 16314 | Values: 75.0 76.0 75.0 183.0 76.0 76.0 76.0 79.0 178.0 75.0 16:41:22 INFO - PROCESS | 16314 | 16:41:22 INFO - PROCESS | 16314 | [#4] audio-oscillator Cycles:10 Average:105.70 Median:85.00 stddev:32.18 (37.9%) stddev-sans-first:33.41 16:41:22 INFO - PROCESS | 16314 | Values: 87.0 85.0 153.0 86.0 84.0 85.0 144.0 89.0 85.0 159.0 16:41:22 INFO - PROCESS | 16314 | 16:41:22 INFO - PROCESS | 16314 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:41:22 INFO - PROCESS | 16314 | Values: 118.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 16:41:22 INFO - PROCESS | 16314 | 16:41:22 INFO - PROCESS | 16314 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 16:41:22 INFO - PROCESS | 16314 | Values: 148.0 147.0 146.0 147.0 147.0 148.0 147.0 147.0 150.0 148.0 16:41:22 INFO - PROCESS | 16314 | 16:41:22 INFO - PROCESS | 16314 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.53 16:41:22 INFO - PROCESS | 16314 | Values: 97.0 96.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 16:41:22 INFO - PROCESS | 16314 | 16:41:22 INFO - PROCESS | 16314 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.50 stddev:2.26 (4.1%) stddev-sans-first:2.28 16:41:22 INFO - PROCESS | 16314 | Values: 52.0 52.0 56.0 52.0 53.0 56.0 52.0 58.0 53.0 56.0 16:41:22 INFO - PROCESS | 16314 | 16:41:22 INFO - PROCESS | 16314 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:62.00 stddev:1.65 (2.7%) stddev-sans-first:1.73 16:41:22 INFO - PROCESS | 16314 | Values: 62.0 62.0 67.0 63.0 62.0 62.0 61.0 62.0 62.0 63.0 16:41:22 INFO - PROCESS | 16314 | 16:41:22 INFO - PROCESS | 16314 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:85.50 stddev:4.02 (4.7%) stddev-sans-first:3.59 16:41:22 INFO - PROCESS | 16314 | Values: 90.0 85.0 89.0 81.0 79.0 80.0 83.0 86.0 86.0 79.0 16:41:22 INFO - PROCESS | 16314 | 16:41:22 INFO - PROCESS | 16314 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:129.50 stddev:6.05 (4.7%) stddev-sans-first:6.33 16:41:22 INFO - PROCESS | 16314 | Values: 127.0 126.0 124.0 125.0 139.0 130.0 123.0 129.0 138.0 137.0 16:41:22 INFO - PROCESS | 16314 | 16:41:22 INFO - PROCESS | 16314 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.40 Median:163.50 stddev:2.72 (1.7%) stddev-sans-first:1.99 16:41:22 INFO - PROCESS | 16314 | Values: 169.0 163.0 163.0 161.0 162.0 160.0 161.0 166.0 164.0 165.0 16:41:22 INFO - PROCESS | 16314 | 16:41:22 INFO - PROCESS | 16314 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:2.51 (3.8%) stddev-sans-first:2.65 16:41:22 INFO - PROCESS | 16314 | Values: 65.0 66.0 68.0 65.0 63.0 64.0 66.0 68.0 71.0 63.0 16:41:22 INFO - PROCESS | 16314 | -------- Summary: end -------- 16:41:22 INFO - PROCESS | 16314 | 16:41:23 INFO - TEST-INFO | 16314: exit 0 16:41:23 INFO - TEST-OK | kraken | took 62053ms 16:41:23 INFO - SUITE-END | took 1175s 16:41:23 INFO - Completed test suite (00:19:35) 16:41:23 INFO - javascript benchmark 16:41:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7236.6158378837235, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.829289389084, 3127.3432579158375, 3144.025352140836, 3154.384894945485, 3164.493681011037, 5380.408155102946, 5550.694711790855, 5568.52667523261, 5659.896320217554, 5700.0, 5556.638818476797, 5561.749721262543, 5589.049861523541, 5615.691136987464, 5644.01229784787, 4981.526754958282, 5070.873228169288, 5082.08522465956, 5123.129068058421, 5194.558462530689, 5147.356580427447, 5151.072806894757, 5155.20094385369, 5200.32395788547, 5220.295260139889, 4912.975435122838, 4963.156263435225, 5017.874553136165, 5091.439941606421, 5106.5659418949435, 5054.671446355975, 5062.848114556569, 5078.5175408336145, 5111.437741848394, 5122.948770512285, 4988.376452943382, 5038.370203724535, 5044.445111037783, 5062.11413002723, 5080.79676812927, 5358.33020872391, 5433.8369848904595, 5507.146392309199, 5514.6691198528215, 5544.722763861791, 5930.199423077873, 5936.7031648417405, 5944.227250457456, 5976.910346344808, 5988.61074030191, 5972.940270597282, 5991.161237426763, 5997.940020599825, 6000.429959153874, 6002.879942401171, 5285.339332583389, 5485.985092757773, 5525.613207075507, 5546.833594992076, 5568.972155139199, 6129.542179248731, 6137.900360318011, 6146.231721034871, 6150.200473938359, 6157.168782214344, 5875.853103672357, 5904.9704751475965, 5915.970420147872, 5922.526197904157, 5943.524518038546, 5750.84983003401, 5889.676067816311, 5931.7627294907725, 5940.79207227745, 5999.730012149464, 5960.403959604005, 5965.0, 5966.463018328372, 5975.970120149372, 6003.5797494174985, 5938.2280303560265, 5956.821295361146, 5962.433568810956, 5964.284285885721, 5969.164316995624, 4286.957130428718, 4395.472543294825, 4427.335899615019, 4428.357888106207, 4435.489918659331, 3963.801809909493, 3968.3849003404516, 3990.980045099814, 3997.140614767839, 4016.8393264269685, 5566.304211973504, 5636.633618814764, 5638.661680299195, 5650.943490565124, 5652.63257888236, 5743.396943320975, 5898.793542226002, 5940.138679891392, 6053.636781793019, 6070.605410648293, 5644.491995720405, 5647.040003199466, 5659.660420374791, 5663.065594176915, 5674.602777805597, 4971.850844474671, 4976.4525902150735, 4978.502149785065, 4995.775190116454, 5014.272930425068, 5815.79644712433, 6069.423404776539, 6130.245269657117, 6150.292716337678, 6166.691665416712, 6036.336003039574, 6042.939570604238, 6047.153398524298, 6069.453749162597, 6088.726007329769, 6213.875722485615, 6243.687815609111, 6252.280987686474, 6266.561340706106, 6274.466670333073, 5700.945325114867, 5739.397363276963, 5885.941140588539, 5925.822225333247, 5954.702264886651, 5989.46094851448, 6008.519318454601, 6035.426634469718, 6053.485453736482, 6064.636121832704, 5874.765009399747, 5880.206172166702, 5885.117232415001, 5886.352501224947, 5908.556858235564, 5551.750171242385, 5771.0, 5778.191053252464, 5788.131780232999, 5882.088276317178, 5840.503557197516, 5888.735006924784, 5892.793752218652, 5894.557908156819, 5934.258217722785, 5853.473187413153, 5864.296284445723, 5911.438413350725, 5915.053591425351, 5924.8815023700145, 5522.0, 5678.20505129274, 5696.259486266758, 5716.0, 5731.5701322400155], "value": 5481.388096486073, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.1267876457157, 590.9556783241256, 592.668105860718, 609.814006727948, 622.9626222426652, 36714.265714685724, 40807.59192408071, 41075.17849643005, 41287.79356103223, 41358.17283654332, 43584.78207608966, 44075.77962110185, 44079.3388099178, 44161.77919110408, 44165.558344416546, 8879.822403551925, 8971.282297416225, 9044.728658140266, 9045.819083618324, 9055.366124371296, 8870.246029087502, 8940.418872773282, 8954.2836573074, 8975.640974361018, 8983.685571005017, 8936.41913275635, 8979.64081436745, 9048.773780655503, 9049.819003619923, 9057.184853363196, 8960.23837973773, 9012.729618111467, 9020.323475739346, 9020.774480638003, 9029.232515236214, 8888.644454221823, 8914.955425222897, 8954.37319387643, 8956.731298061068, 8960.731178064669, 42684.57315426837, 42866.78566607147, 42909.78545107286, 43136.0, 43395.566044339466, 2514.5348110599416, 3131.1389367923775, 3366.4445366514497, 3446.2613905879416, 3488.860445582199, 31586.0, 32359.51460728091, 32518.34963300721, 32631.184220394443, 32668.346633067205, 4064.4106604542176, 4069.8982525436804, 4128.91742165155, 4129.215449064698, 4302.333138363528, 312174.0, 313219.0, 314663.0, 315333.99999999773, 315768.0, 34933.82533087318, 35249.47125793115, 35481.29037419289, 35509.644903551154, 35693.64306356955, 36379.0, 36439.63560364416, 36494.0, 36515.63484365176, 36588.81705591455, 15907.204639768197, 16698.666026679643, 16716.665666686597, 16726.498205053867, 16894.408695695838, 12640.431180596896, 12784.744305113845, 12785.721427857326, 12792.872071279355, 12814.0, 19077.90461047686, 19110.23559057622, 19125.713114303297, 19286.0, 19294.167054129834, 7246.710131594783, 7261.927380726231, 7309.551300314454, 7345.632718364061, 7492.363149132276, 868.5700578213824, 972.2610815780058, 1042.4839704346398, 1078.9190810689072, 1079.4171147580219, 26505.734942650328, 27814.0, 28115.859420703175, 28245.858770706014, 28350.43299134047, 994.005994005994, 1017.6896046705677, 1028.4189432970347, 1058.2433560004633, 1078.6710053433621, 13546.390412431267, 13842.93078534621, 14853.48012819546, 14878.256087195814, 15065.774013389808, 568438.0, 580408.0, 587266.0, 588698.0, 589045.0, 58175.70912145412, 58589.0, 59025.11462327983, 59032.40967590355, 59066.70466647639, 1350.1494058742928, 1389.0, 1395.2605119286795, 1409.4925826702583, 1414.5473448496382, 25498.872505638094, 25660.871695641403, 26373.0, 26759.464810704067, 26825.195244142706, 51139.488605113474, 52177.21734174067, 52290.47709523008, 52388.73805630948, 52493.475065250386, 478957.4729769022, 479857.0, 479975.0, 480041.0, 480496.0, 28566.285842853264, 28751.424971500033, 29171.85414073001, 29204.853975730835, 29276.707232927398, 39506.60493395144, 40265.79867100646, 40316.39525407062, 40332.39501407422, 40497.39253911252, 35083.473747893295, 35912.640873591976, 36348.27303453969, 36555.634443655224, 36726.816365918, 40615.18769624532, 40644.39033414442, 41476.58523414727, 42896.35655465233, 44800.77599611981, 31854.0, 35587.0, 35784.0, 36084.0, 36970.8151459241, 35009.474857876645, 36833.0, 37613.435798462495, 37702.811485942395, 38207.0, 24713.505729884942, 24981.625275621245, 25028.749712502642, 25190.874045629655, 25238.873805630854], "value": 18976.02323736395, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.37083924043037, 391.4031102568581, 410.1264307026035, 410.8500397354965, 424.89165262857966, 13928.791068133985, 17494.65010699787, 19103.52241193969, 19139.33012344568, 19646.312379066734, 18951.52621184471, 19339.4198174055, 19525.41423757286, 20124.39626811198, 20251.898740506276, 5809.186713860063, 5825.1844741736195, 5971.343152253248, 6054.878902421949, 6064.151018857364, 6110.725017374229, 6117.602355846878, 6128.295246046695, 6153.907691384633, 6155.0, 6188.319284878659, 6671.899921501182, 6674.899876501856, 6715.8656826863435, 6721.798346049626, 6493.090967264587, 6607.966960165217, 6624.536282460205, 6665.800025999228, 6705.295943925891, 5960.284765828085, 5983.252093488314, 5990.071538911476, 5991.910121348184, 5996.070609055603, 14540.563783086523, 14964.326605302787, 23333.716645584485, 24226.757732422626, 25180.370490737696, 2341.1688850458013, 2487.8009759219217, 2870.5550639650887, 2959.4377068356944, 3042.908712738599, 10001.299909006373, 10736.30214036093, 10916.07213386863, 11161.107111431065, 14161.716765664733, 1957.354073155855, 2031.7460317460318, 2044.4377796106041, 2058.835293176542, 2059.1145807302855, 84960.57519712424, 85075.0, 85166.57416712877, 86501.0, 86986.13013869844, 11087.168462365355, 11156.16328775345, 11359.716007099723, 11365.261258018203, 11472.77054458906, 15908.68182636364, 15933.0, 15937.760933586005, 15948.288790905573, 15948.601284967968, 7559.1684914659345, 7704.768856934301, 7897.802554936173, 8039.437239393304, 8075.919240807634, 7229.120428688579, 7273.927260727431, 7329.510796632914, 7526.247375262539, 7529.117720569858, 4726.409198850144, 4772.308015337757, 4854.368932038812, 4891.1685013547785, 5003.174476211457, 2010.4069299556666, 2027.3613811649284, 2048.7848775878615, 2077.4494758888904, 2094.172801743303, 819.5246756880995, 873.5850471026339, 893.718478679214, 904.5793705926644, 982.0474140084107, 15595.298211580506, 16077.598060048593, 16113.436029738903, 16255.10596917181, 16650.58373540671, 880.8854848869734, 885.4333226734894, 901.1124042817819, 913.9405938613969, 927.1609193679731, 8985.146411090936, 9598.760030999281, 9616.807663846685, 9635.855462168072, 9688.41869487833, 345830.0, 453717.0, 458349.0, 504240.0, 514262.0, 95128.0, 95664.0, 96677.51661241648, 99776.0, 100125.0, 1005.1305620638242, 1021.1371391174595, 1050.406520316019, 1054.9367037977745, 1057.0644979193316, 15597.117449547784, 15827.287772050055, 15832.92083539575, 16793.0, 16949.66100677955, 43450.34824477572, 44280.557194427645, 44473.11053778971, 44676.55323446724, 45561.544384557055, 58520.414795851495, 60632.69683651553, 61528.07707884475, 61673.38326616856, 61677.69161154165, 6600.174978127734, 8441.662333506836, 8730.519821409884, 8984.216916228206, 9329.393589416666, 9828.110412724871, 13167.2757998311, 13659.317034148451, 13770.104943178661, 13872.306384680927, 10751.0, 11223.887761122285, 11235.66293011211, 11442.199046067028, 11454.370009649549, 11387.259828111146, 11504.482298296763, 11719.589814356457, 11723.531058757895, 11751.529938802352, 11137.610183643534, 11388.715282118013, 11475.770484590428, 11478.450409194651, 11840.230385024946, 7541.208173141741, 7936.127026027248, 8840.160184782435, 8892.421992570462, 9071.773205669911, 11034.944825275823, 11340.149488788209, 11410.885891140982, 11573.189876708886, 11627.302361858316], "value": 9252.997077548445, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.3243456661783, 1528.9770653440198, 1683.1920678074523, 1745.5199820049493, 1826.3242600237913, 7771.378289736822, 8608.440451370656, 8699.130086991298, 9263.814723705522, 9339.34624576279, 8781.165789250026, 9027.232685221765, 9141.177294043535, 9141.954290228556, 9169.31230157739, 2349.5535848188833, 2353.364591560278, 2369.1944738788807, 2393.6768536247646, 2394.784469397754, 2326.3021093671914, 2362.503874186414, 2370.4073981504625, 2390.1395497620842, 2391.1272385579227, 2372.418757404438, 2390.079819269585, 2392.3301475586777, 2397.880105994693, 2399.7720216579396, 2280.6579013147993, 2282.281081459335, 2285.6571514272828, 2291.1179196009575, 2344.10923848938, 2291.713535808024, 2302.412884714404, 2304.2280835919987, 2308.803751681109, 2311.6879221305076, 8784.121587841164, 9001.414908030956, 9011.098890111001, 9035.32235082365, 9039.819203615956, 5177.637565370425, 5212.635115541913, 5259.474052594748, 5274.2879711238875, 5276.182191760283, 3193.505006723938, 3356.848941797625, 3413.453847384407, 3429.4684323929832, 3454.240067185215, 1150.223599070624, 1193.4331192683492, 1220.1580909172642, 1222.1628184693514, 1234.370471059757, 12126.333051682153, 12195.634130976085, 12235.877641223562, 12280.38598070102, 12303.630891073193, 4452.465704115462, 4557.134144512598, 4725.834595789131, 4729.408823897013, 4783.617310615143, 10215.846762298572, 10290.0, 10306.896931030593, 10308.587656493657, 10312.690619281433, 5280.6039547034125, 5296.073187192226, 5318.840434786963, 5318.8936221276135, 5325.094733895247, 4194.328907374806, 4607.3319368691355, 4716.410448693913, 4776.188048031843, 4888.853334399973, 4021.939670904939, 4103.322951712934, 4146.232946904832, 4174.998000479863, 4199.223143718422, 1304.4651692805903, 1344.8722371374704, 1355.6339788257312, 1364.3519328318969, 1368.5825823124044, 779.5089093870826, 832.5296207642783, 866.7226487523932, 896.7982204004047, 920.0063930954553, 5404.594655400861, 5444.455554444524, 5461.590380721462, 5479.616426850162, 5570.777168913198, 463.2981033733896, 479.8968221832323, 482.13216210820383, 487.4954422173034, 487.8731529802277, 3550.715942724576, 3676.981615091961, 3730.4963829883163, 3746.138388170736, 3805.1438426354403, 10989.0, 11131.443427828575, 11133.554657813758, 11199.888001120047, 11324.207305488537, 11285.887141128647, 11307.321560706385, 11310.83033754478, 11313.094952403788, 11327.433628318551, 7930.484518506279, 8051.5169089853625, 8128.674853005932, 8228.50628962264, 8380.790480238044, 5548.361938377138, 5830.883382332415, 5915.792947246998, 5941.257342832146, 6055.303640081447, 9811.0, 10182.18542516582, 10188.592456301962, 10370.948145259226, 10376.236039873089, 10223.846642300223, 10274.22943279272, 10401.427921464392, 10498.737531561772, 10595.417252050904, 7307.890381644386, 8141.104478507478, 8197.83604327922, 8203.58982050907, 8479.109693482096, 8424.410291279797, 8453.91546084556, 8487.660493580435, 8499.57502124879, 8506.319494440553, 7621.618919053914, 7642.465027448247, 7766.068071831416, 7827.45207835446, 7856.332211762065, 7557.5465472071855, 7602.923970760222, 7627.237276272328, 7658.119316278699, 7750.379969602531, 6450.645214513247, 6528.053432252392, 6528.575642583217, 6543.836404089745, 6557.147570815954, 4915.778789954532, 4972.776225069808, 4979.253112033224, 5018.5232402921665, 5137.691738495702, 4929.038837426668, 4972.0, 4980.0, 5081.11080560893, 5085.0], "value": 4554.075674338592, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.79312136793146, 333.6746671994804, 335.71631970984515, 339.75198105383083, 342.93312804003216, 5296.5434505511, 5354.759035843386, 5543.528800051995, 5638.8026419075395, 5643.25059231638, 5410.215518749779, 5469.343678758554, 5492.176173573966, 5494.0934745767, 5528.170774383844, 4313.0, 4332.458442694663, 4340.913181736363, 4341.739495630272, 4343.435353404053, 4209.85297498275, 4283.742975421469, 4324.416203812477, 4365.279728844736, 4375.562443755615, 4231.830726770925, 4261.659067274611, 4271.722338048017, 4287.7856107194675, 4292.463442069741, 4288.76411797351, 4293.65650747941, 4323.286657701507, 4336.56634336567, 4341.111616446824, 3483.303339332144, 3824.7131465140224, 3834.7183425861845, 3837.808109594509, 3845.1156234066043, 5274.208868669692, 5299.470052994709, 5329.840104796862, 5336.946630533684, 5340.652857564246, 4753.714777113384, 4807.158747219222, 4814.277858321279, 4819.421669399694, 4820.638452116105, 5517.751701173457, 5664.688442135681, 5669.092945128801, 5672.773089076432, 5713.657180569179, 4065.7763822989723, 4070.450489183952, 4077.796110194508, 4107.260693075245, 4120.299549076664, 5983.730732117066, 5988.461038506555, 6000.489958353545, 6006.0, 6021.909671354933, 4067.51189857219, 4191.937120943188, 4222.218889505451, 4237.406763053175, 4253.893652658647, 4213.272558251102, 4224.134052519226, 4226.964393723558, 4233.026403927114, 4235.174141042467, 4865.294532292798, 4889.633277504201, 4891.2174052152195, 4902.583280421133, 4908.8772780680765, 5683.460071293221, 5759.8560035999435, 5780.988327042751, 5809.779946211258, 5821.457313811843, 1448.9782653260208, 1467.2736995187238, 1469.280052774133, 1472.580314610331, 1474.7198032374029, 909.3679892474798, 939.4316438554713, 942.3733217410345, 951.6478902805868, 952.9809403812023, 4760.785764640599, 4774.474807771142, 4826.7827947742435, 4850.587700045465, 4883.4139903211135, 5187.610929180251, 5198.518422249641, 5208.557272631869, 5234.502722241381, 5238.68567885928, 4687.882802929954, 4899.971006088761, 4915.90168196634, 4942.703437793672, 4947.752612369367, 2730.645016147928, 2734.4941185880675, 2738.561830107173, 2752.628395166627, 2757.9586306205424, 5289.285946397187, 5305.798093791033, 5310.654807437581, 5382.219578161144, 5401.783928642811, 5077.568406685399, 5095.8980820383385, 5234.586661601346, 5250.159974404077, 5262.447443018505, 5320.989012087691, 5344.4922732340365, 5358.66897899415, 5369.758360873692, 5383.67697938125, 5141.794328226829, 5170.5346518813485, 5201.7399130044105, 5209.374875014871, 5237.502437268454, 4855.830045948375, 5054.747262636927, 5139.434662187082, 5147.6911385317, 5178.4366738463195, 5423.430539793423, 5439.374471935778, 5443.237946687546, 5449.719315960825, 5489.560835133259, 3787.958311464369, 3806.707198273529, 4120.743173332163, 4310.655147588122, 4310.655147588248, 5770.769169233184, 5798.478136967693, 5830.795922142875, 5852.18069470266, 5858.3596592954045, 5512.283403157564, 5700.344460386943, 5724.570657200643, 5773.566982476415, 5781.190633311424, 5661.405552416937, 5682.005649011489, 5683.460071293221, 5683.5453163747625, 5713.514351280021, 5662.8018019370775, 5702.800401985911, 5746.023176060164, 5775.797847075332, 5790.710464476843, 5520.834374968757, 5726.4273572642405, 5761.02062649359, 5775.826725198251, 5779.8555036124435, 5635.915461268002, 5647.5481961442165, 5670.404607516151, 5713.857153571194, 5716.857078573069], "value": 4220.939076586141, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.5320275806935, 716.6345163966379, 732.406750532069, 751.6730222353277, 755.0, 16251.918740406296, 17630.735538966925, 17697.734533981984, 17757.55606109848, 17804.020778857175, 14229.928850355735, 14514.854851451482, 14652.560423187295, 16005.27976241069, 16016.59958501038, 805.4200975297791, 823.0329362998483, 825.4263287015526, 825.9587020648974, 826.3017750001239, 802.6227672993713, 822.9341652667772, 823.4277177361736, 826.8470332988386, 829.6308142876422, 866.0906048648925, 867.4101610904582, 868.513632365874, 871.0723079919865, 873.1268731268731, 859.9656013759442, 863.7926897544606, 864.7621903976425, 865.0527672198932, 866.1684782608703, 626.0171530696808, 632.4497687012283, 633.733831790649, 634.0900807341434, 634.43852190811, 16884.240209190615, 17016.0, 17063.14684265794, 17090.401835935805, 17103.914480427517, 14892.62768430798, 14893.627659308604, 15265.313060912285, 15403.0, 15602.531924042183, 12285.38573071343, 12413.937930310381, 12443.813342799865, 12684.112112152154, 12782.87217127826, 3912.726109172359, 3997.1006523532265, 3998.8800335989968, 4063.065494936181, 4152.0, 90149.0, 90985.54507227488, 92691.0, 93229.53385233098, 93806.5309673454, 11681.299122052704, 12218.755624887452, 12239.938800305941, 12243.265404075784, 12530.310832904277, 22850.20024299175, 22861.542769144526, 22903.427414314774, 22925.770742292698, 22932.4266893329, 8045.316148127475, 8191.549464779375, 8453.154684531497, 8586.441881277697, 8704.303655707528, 4903.607711383081, 5000.993838203155, 5019.623528235397, 5051.318072060299, 5057.21613149955, 3526.153723106436, 3635.345637785171, 3654.616265292106, 3655.6161603031833, 3662.102784817737, 555.5444535480948, 562.061357532921, 575.2722805650855, 578.8408187748403, 581.2588949089944, 673.5621845800171, 717.5515302935665, 727.7816655003478, 756.1266736918867, 778.381186956371, 9507.15736292043, 10060.699987084998, 10061.791659618597, 10139.898601014043, 10233.795324093626, 705.5766540075913, 719.4064896460441, 733.1202556931703, 738.5605564689001, 768.9346405555591, 4612.86161415158, 4856.2958371036, 4882.658213925062, 4893.0, 4976.925346119811, 103980.0, 119907.40046299713, 123223.0, 125580.0, 132426.0, 65806.34193658098, 69138.0, 102183.0, 109800.66694331072, 113843.43078284555, 56528.99999999918, 59121.40878591245, 80312.19687803047, 83179.6025496813, 92613.5369323149, 9770.071843174886, 10238.283320167517, 10273.434961076913, 10362.0, 10401.479926003822, 49246.50753492419, 51419.82962044579, 52583.211251830486, 53931.73034134804, 54739.978602352916, 72757.0, 75298.24701752912, 81655.0, 82418.0, 83098.0, 12474.563390281297, 12585.24488530691, 12590.874091258971, 12773.936130319289, 13108.475660973836, 14750.926245369134, 15130.0, 15346.539603811903, 15607.141607211712, 15845.0, 13226.603201903958, 14080.929595351958, 14300.570982870531, 14433.35049922777, 14737.336819843347, 13582.185068895898, 13954.790678139632, 14028.0, 14287.285635718381, 14435.278236087943, 13444.731105378034, 14046.367913444124, 14214.147151170962, 14306.57080287593, 14900.105993640416, 10317.17462602975, 10656.786864262827, 10852.674419767103, 10889.237753357505, 10955.50700218476, 10945.945270273916, 11341.716457088309, 11401.144914131639, 11479.25384849982, 11501.424928753697], "value": 7762.1572676971155, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 109.0, 113.0, 112.0, 112.0, 117.0, 111.0, 113.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 117.0, 152.0, 193.0, 124.0, 148.0, 152.0, 125.0, 182.0, 121.0], "value": 145.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 165.0, 163.0, 169.0, 170.0, 162.0, 161.0, 161.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 183.0, 76.0, 76.0, 76.0, 79.0, 178.0, 75.0], "value": 96.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 153.0, 86.0, 84.0, 85.0, 144.0, 89.0, 85.0, 159.0], "value": 105.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 147.0, 147.0, 148.0, 147.0, 147.0, 150.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 56.0, 52.0, 53.0, 56.0, 52.0, 58.0, 53.0, 56.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 67.0, 63.0, 62.0, 62.0, 61.0, 62.0, 62.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 85.0, 89.0, 81.0, 79.0, 80.0, 83.0, 86.0, 86.0, 79.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 126.0, 124.0, 125.0, 139.0, 130.0, 123.0, 129.0, 138.0, 137.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 163.0, 163.0, 161.0, 162.0, 160.0, 161.0, 166.0, 164.0, 165.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 68.0, 65.0, 63.0, 64.0, 66.0, 68.0, 71.0, 63.0], "value": 65.9, "unit": "score"}]}]} 16:41:23 INFO - Return code: 0 16:41:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:41:23 ERROR - # TBPL SUCCESS # 16:41:23 INFO - Running post-action listener: _resource_record_post_action 16:41:23 INFO - [mozharness: 2016-08-16 23:41:23.370052Z] Finished run-tests step (success) 16:41:23 INFO - Running post-run listener: _resource_record_post_run 16:41:23 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 420995072; Read time: 20; Write time: 329420 16:41:23 INFO - TinderboxPrint: CPU usage
13.4% 16:41:23 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 16:41:23 INFO - TinderboxPrint: I/O write bytes / time
420,995,072 / 329,420 16:41:23 INFO - TinderboxPrint: CPU idle
8,237.8 (86.6%) 16:41:23 INFO - TinderboxPrint: CPU user
1,218.8 (12.8%) 16:41:23 INFO - TinderboxPrint: Swap in / out
0 / 0 16:41:23 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 129732608; Read time: 0; Write time: 100412 16:41:23 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291262464; Read time: 20; Write time: 229008 16:41:24 INFO - Running post-run listener: _upload_blobber_files 16:41:24 INFO - Blob upload gear active. 16:41:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:41:24 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 16:41:24 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'] 16:41:24 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 16:41:24 INFO - (blobuploader) - INFO - Open directory for files ... 16:41:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:41:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:41:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:41:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:41:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:41:25 INFO - (blobuploader) - INFO - Done attempting. 16:41:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:41:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:41:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:41:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:41:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:41:25 INFO - (blobuploader) - INFO - Done attempting. 16:41:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:41:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:41:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:41:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:41:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:41:29 INFO - (blobuploader) - INFO - Done attempting. 16:41:29 INFO - (blobuploader) - INFO - Iteration through files over. 16:41:29 INFO - Return code: 0 16:41:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:41:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:41:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5308ef4bf513128eb0361b688989e2bb64e65803728c336f1186f760df75b0a5dcc35eeca6187f6aca37beb35c26996a9a9653e1e5259a2e7b5fe3f3810be231", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5a7ccc618a4e3a3ebe9ae4963cada4e382e966f100d00940d34d2145ac17cd454ab98388f1642ebc68e08b8ee2a01962c4988506219eef356c9f2209bff4afc0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/322e7087bd1e7eeac4a42992c80f93bf55b44f36aed30e64d6e5119e4f94119628930b6c1db3879c216a583d6bb6c3c7df2226b9b32cb30d2a37c1f19984bcab"} 16:41:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:41:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:41:29 INFO - Contents: 16:41:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5308ef4bf513128eb0361b688989e2bb64e65803728c336f1186f760df75b0a5dcc35eeca6187f6aca37beb35c26996a9a9653e1e5259a2e7b5fe3f3810be231", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5a7ccc618a4e3a3ebe9ae4963cada4e382e966f100d00940d34d2145ac17cd454ab98388f1642ebc68e08b8ee2a01962c4988506219eef356c9f2209bff4afc0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/322e7087bd1e7eeac4a42992c80f93bf55b44f36aed30e64d6e5119e4f94119628930b6c1db3879c216a583d6bb6c3c7df2226b9b32cb30d2a37c1f19984bcab"} 16:41:29 INFO - Running post-run listener: copy_logs_to_upload_dir 16:41:29 INFO - Copying logs to upload dir... 16:41:29 INFO - mkdir: /builds/slave/test/build/upload/logs 16:41:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.650460 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-16 16:41:29.523778) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 16:41:29.527609) ========= 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=c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771 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/5308ef4bf513128eb0361b688989e2bb64e65803728c336f1186f760df75b0a5dcc35eeca6187f6aca37beb35c26996a9a9653e1e5259a2e7b5fe3f3810be231", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5a7ccc618a4e3a3ebe9ae4963cada4e382e966f100d00940d34d2145ac17cd454ab98388f1642ebc68e08b8ee2a01962c4988506219eef356c9f2209bff4afc0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/322e7087bd1e7eeac4a42992c80f93bf55b44f36aed30e64d6e5119e4f94119628930b6c1db3879c216a583d6bb6c3c7df2226b9b32cb30d2a37c1f19984bcab"} build_url:https://queue.taskcluster.net/v1/task/MN49L8IwSBeDjdlPDnJ4wQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011441 build_url: 'https://queue.taskcluster.net/v1/task/MN49L8IwSBeDjdlPDnJ4wQ/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/5308ef4bf513128eb0361b688989e2bb64e65803728c336f1186f760df75b0a5dcc35eeca6187f6aca37beb35c26996a9a9653e1e5259a2e7b5fe3f3810be231", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5a7ccc618a4e3a3ebe9ae4963cada4e382e966f100d00940d34d2145ac17cd454ab98388f1642ebc68e08b8ee2a01962c4988506219eef356c9f2209bff4afc0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/322e7087bd1e7eeac4a42992c80f93bf55b44f36aed30e64d6e5119e4f94119628930b6c1db3879c216a583d6bb6c3c7df2226b9b32cb30d2a37c1f19984bcab"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 16:41:29.553494) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 16:41:29.553851) ========= 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=c6927cf182745ad25b1d38b9000001fe-1471388568.328393-546709771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 16:41:29.636255) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 16:41:29.636575) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 16:41:29.636890) ========= ========= Total master_lag: 0.17 =========