builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-052 starttime: 1471821230.9 results: success (0) buildid: 20160821133003 builduid: d9771ec68d66488382d1263cef831fc2 revision: f823117225343b73be4df1ee89c904580d66d148 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-21 16:13:50.898970) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-21 16:13:50.899367) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-21 16:13:50.899647) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-21 16:13:50.958894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 16:13:50.959165) ========= 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=826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-21 16:13: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-08-21 16:13:51 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077329 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 16:13:51.062513) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 16:13:51.062785) ========= 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=826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018792 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 16:13:51.127628) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 16:13:51.127920) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f823117225343b73be4df1ee89c904580d66d148 --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 f823117225343b73be4df1ee89c904580d66d148 --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=826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-21 16:13:51,712 truncating revision to first 12 chars 2016-08-21 16:13:51,712 Setting DEBUG logging. 2016-08-21 16:13:51,712 attempt 1/10 2016-08-21 16:13:51,712 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f82311722534?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-21 16:13:51,973 unpacking tar archive at: mozilla-inbound-f82311722534/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549123 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 16:13:51.696444) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-21 16:13:51.696756) ========= script_repo_revision: f823117225343b73be4df1ee89c904580d66d148 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-21 16:13:51.697167) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-21 16:13:51.697438) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-21 16:13:51.708291) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-21 16:13:51.708777) ========= /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=826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:13:52 INFO - MultiFileLogger online at 20160821 16:13:52 in /builds/slave/test 16:13: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:13:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:13:52 INFO - {'append_to_log': False, 16:13:52 INFO - 'base_work_dir': '/builds/slave/test', 16:13:52 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:13:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:13:52 INFO - 'branch': 'Mozilla-Inbound', 16:13:52 INFO - 'buildbot_json_path': 'buildprops.json', 16:13:52 INFO - 'config_files': ('talos/linux_config.py',), 16:13:52 INFO - 'default_actions': ('clobber', 16:13:52 INFO - 'read-buildbot-config', 16:13:52 INFO - 'download-and-extract', 16:13:52 INFO - 'populate-webroot', 16:13:52 INFO - 'create-virtualenv', 16:13:52 INFO - 'install', 16:13:52 INFO - 'run-tests'), 16:13:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:13:52 INFO - 'download_minidump_stackwalk': True, 16:13:52 INFO - 'download_symbols': 'ondemand', 16:13:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:13:52 INFO - 'tooltool.py': '/tools/tooltool.py', 16:13:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:13:52 INFO - '/tools/misc-python/virtualenv.py')}, 16:13:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:13:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:13:52 INFO - 'installer_path': 'installer.exe', 16:13:52 INFO - 'log_level': 'info', 16:13:52 INFO - 'log_name': 'talos', 16:13:52 INFO - 'log_to_console': True, 16:13:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:13:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:13:52 INFO - 'opt_config_files': (), 16:13:52 INFO - 'pip_index': False, 16:13:52 INFO - 'sps_profile': False, 16:13:52 INFO - 'sps_profile_interval': 0, 16:13:52 INFO - 'suite': 'dromaeojs-e10s', 16:13:52 INFO - 'system_bits': '32', 16:13:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:13:52 INFO - 'title': 'talos-linux64-ix-052', 16:13:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:13:52 INFO - 'use_talos_json': True, 16:13:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:13:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:13:52 INFO - 'work_dir': 'build'} 16:13:52 INFO - [mozharness: 2016-08-21 23:13:52.386045Z] Running clobber step. 16:13:52 INFO - Running pre-action listener: _resource_record_pre_action 16:13:52 INFO - Running main action method: clobber 16:13:52 INFO - rmtree: /builds/slave/test/build 16:13:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:13:52 INFO - Running post-action listener: _resource_record_post_action 16:13:52 INFO - [mozharness: 2016-08-21 23:13:52.845564Z] Finished clobber step (success) 16:13:52 INFO - [mozharness: 2016-08-21 23:13:52.845666Z] Running read-buildbot-config step. 16:13:52 INFO - Running pre-action listener: _resource_record_pre_action 16:13:52 INFO - Running main action method: read_buildbot_config 16:13:52 INFO - Using buildbot properties: 16:13:52 INFO - { 16:13:52 INFO - "project": "", 16:13:52 INFO - "product": "firefox", 16:13:52 INFO - "script_repo_revision": "production", 16:13:52 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 16:13:52 INFO - "repository": "", 16:13:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 16:13:52 INFO - "buildid": "20160821133003", 16:13:52 INFO - "pgo_build": "True", 16:13:52 INFO - "basedir": "/builds/slave/test", 16:13:52 INFO - "buildnumber": 1248, 16:13:52 INFO - "slavename": "talos-linux64-ix-052", 16:13:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:13:52 INFO - "platform": "ubuntu64_hw", 16:13:52 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:13:52 INFO - "branch": "mozilla-inbound", 16:13:52 INFO - "repo_path": "integration/mozilla-inbound", 16:13:52 INFO - "revision": "f823117225343b73be4df1ee89c904580d66d148", 16:13:52 INFO - "stage_platform": "linux64-pgo", 16:13:52 INFO - "builduid": "d9771ec68d66488382d1263cef831fc2", 16:13:52 INFO - "slavebuilddir": "test" 16:13:52 INFO - } 16:13:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:13:52 INFO - Running post-action listener: _resource_record_post_action 16:13:52 INFO - [mozharness: 2016-08-21 23:13:52.848093Z] Finished read-buildbot-config step (success) 16:13:52 INFO - [mozharness: 2016-08-21 23:13:52.848182Z] Running download-and-extract step. 16:13:52 INFO - Running pre-action listener: _resource_record_pre_action 16:13:52 INFO - Running main action method: download_and_extract 16:13:52 INFO - mkdir: /builds/slave/test/build/tests 16:13: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:13:52 INFO - trying https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:13:52 INFO - Downloading https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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:13:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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:13:53 INFO - Downloaded 1361 bytes. 16:13:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:13:53 INFO - Using the following test package requirements: 16:13:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:13:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:13:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:13:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:53 INFO - u'jsshell-linux-x86_64.zip'], 16:13:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:13:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:13:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:13:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:13:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:13:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:13:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:13: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:13:53 INFO - trying https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:13:53 INFO - Downloading https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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:13:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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:13:55 INFO - Downloaded 21921208 bytes. 16:13:55 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:13:59 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:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:59 INFO - trying https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:13:59 INFO - Downloading https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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:13:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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:14:00 INFO - Downloaded 21921208 bytes. 16:14:00 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:14: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:14:04 INFO - trying https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:14:04 INFO - Downloading https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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:14:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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:14:06 INFO - Downloaded 14413981 bytes. 16:14:06 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:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:06 INFO - trying https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:14:06 INFO - Downloading https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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:14:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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:14:08 INFO - Downloaded 59698686 bytes. 16:14:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:14:08 INFO - mkdir: /builds/slave/test/properties 16:14:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:14:08 INFO - Writing to file /builds/slave/test/properties/build_url 16:14:08 INFO - Contents: 16:14:08 INFO - build_url:https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:14:09 INFO - Running post-action listener: _resource_record_post_action 16:14:09 INFO - Running post-action listener: set_extra_try_arguments 16:14:09 INFO - [mozharness: 2016-08-21 23:14:09.588437Z] Finished download-and-extract step (success) 16:14:09 INFO - [mozharness: 2016-08-21 23:14:09.588661Z] Running populate-webroot step. 16:14:09 INFO - Running pre-action listener: _resource_record_pre_action 16:14:09 INFO - Running main action method: populate_webroot 16:14:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:14:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:14:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:14:09 INFO - '--tppagecycles', 16:14:09 INFO - '7'], 16:14:09 INFO - 'tests': ['tsvgm']}}, 16:14:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:14:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:14:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:14:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:14:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:14:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:14:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:09 INFO - 'talos_options': ['--disable-e10s'], 16:14:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:14:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:14:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:09 INFO - 'talos_options': ['--disable-e10s'], 16:14:09 INFO - 'tests': ['damp', 'tps']}, 16:14:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:09 INFO - 'tests': ['damp', 'tps']}, 16:14:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:14:09 INFO - 'tests': ['dromaeo_dom']}, 16:14:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:14:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:14:09 INFO - 'tests': ['basic_compositor_video']}, 16:14:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:14:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:14:09 INFO - 'tests': ['a11yr', 16:14:09 INFO - 'ts_paint', 16:14:09 INFO - 'tpaint', 16:14:09 INFO - 'sessionrestore', 16:14:09 INFO - 'sessionrestore_no_auto_restore', 16:14:09 INFO - 'tabpaint']}, 16:14:09 INFO - 'other-e10s': {'tests': ['a11yr', 16:14:09 INFO - 'ts_paint', 16:14:09 INFO - 'tpaint', 16:14:09 INFO - 'sessionrestore', 16:14:09 INFO - 'sessionrestore_no_auto_restore', 16:14:09 INFO - 'tabpaint']}, 16:14:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:14:09 INFO - 'ts_paint', 16:14:09 INFO - 'tpaint', 16:14:09 INFO - 'sessionrestore', 16:14:09 INFO - 'sessionrestore_no_auto_restore', 16:14:09 INFO - 'tabpaint']}, 16:14:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:14:09 INFO - 'ts_paint', 16:14:09 INFO - 'tpaint', 16:14:09 INFO - 'sessionrestore', 16:14:09 INFO - 'sessionrestore_no_auto_restore', 16:14:09 INFO - 'tabpaint']}, 16:14:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:14:09 INFO - 'tests': ['a11yr', 16:14:09 INFO - 'ts_paint', 16:14:09 INFO - 'tpaint', 16:14:09 INFO - 'sessionrestore', 16:14:09 INFO - 'sessionrestore_no_auto_restore', 16:14:09 INFO - 'tabpaint']}, 16:14:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:14:09 INFO - 'tests': ['a11yr', 16:14:09 INFO - 'ts_paint', 16:14:09 INFO - 'tpaint', 16:14:09 INFO - 'sessionrestore', 16:14:09 INFO - 'sessionrestore_no_auto_restore', 16:14:09 INFO - 'tabpaint']}, 16:14:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:14:09 INFO - 'tests': ['tsvgx', 16:14:09 INFO - 'tsvgr_opacity', 16:14:09 INFO - 'tart', 16:14:09 INFO - 'tscrollx', 16:14:09 INFO - 'cart']}, 16:14:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:14:09 INFO - 'tsvgr_opacity', 16:14:09 INFO - 'tart', 16:14:09 INFO - 'tscrollx', 16:14:09 INFO - 'cart']}, 16:14:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:09 INFO - 'talos_options': ['--disable-e10s'], 16:14:09 INFO - 'tests': ['tp5o']}, 16:14:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:09 INFO - 'tests': ['tp5o']}, 16:14:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:09 INFO - 'talos_options': ['--disable-e10s', 16:14:09 INFO - '--xperf_path', 16:14:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:14:09 INFO - 'tests': ['tp5n']}, 16:14:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:09 INFO - 'talos_options': ['--xperf_path', 16:14:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:14:09 INFO - 'tests': ['tp5n']}}, 16:14:09 INFO - 'talos.zip': {'path': '', 16:14:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:14:09 INFO - Running post-action listener: _resource_record_post_action 16:14:09 INFO - [mozharness: 2016-08-21 23:14:09.603843Z] Finished populate-webroot step (success) 16:14:09 INFO - [mozharness: 2016-08-21 23:14:09.603931Z] Running create-virtualenv step. 16:14:09 INFO - Running pre-action listener: _resource_record_pre_action 16:14:09 INFO - Running main action method: create_virtualenv 16:14:09 INFO - Creating virtualenv /builds/slave/test/build/venv 16:14:09 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:14:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:14:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:14:09 INFO - Using real prefix '/usr' 16:14:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:14:10 INFO - Installing distribute.............................................................................................................................................................................................done. 16:14:12 INFO - Installing pip.................done. 16:14:12 INFO - Return code: 0 16:14:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:14:12 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:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:12 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:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:12 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 0x7f586a317f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3090>, '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 0x1ce69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6e40>, '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': '826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818', '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:14:12 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:14:12 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:14:12 INFO - Using env: {'DISPLAY': ':0', 16:14:12 INFO - 'HOME': '/home/cltbld', 16:14:12 INFO - 'LANG': 'en_US.UTF-8', 16:14:12 INFO - 'LANGUAGE': 'en_US:en', 16:14:12 INFO - 'LOGNAME': 'cltbld', 16:14:12 INFO - 'MAIL': '/var/mail/cltbld', 16:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:12 INFO - 'MOZ_NO_REMOTE': '1', 16:14:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:12 INFO - 'NO_EM_RESTART': '1', 16:14:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:12 INFO - 'PWD': '/builds/slave/test', 16:14:12 INFO - 'SHELL': '/bin/bash', 16:14:12 INFO - 'SHLVL': '1', 16:14:12 INFO - 'TERM': 'linux', 16:14:12 INFO - 'TMOUT': '86400', 16:14:12 INFO - 'USER': 'cltbld', 16:14:12 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818', 16:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:12 INFO - '_': '/tools/buildbot/bin/python'} 16:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:12 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:14:12 INFO - Cleaning up... 16:14:12 INFO - Return code: 0 16:14:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:14:12 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:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:12 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:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:12 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 0x7f586a317f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3090>, '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 0x1ce69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6e40>, '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': '826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818', '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:14:12 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:14:12 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:14:12 INFO - Using env: {'DISPLAY': ':0', 16:14:12 INFO - 'HOME': '/home/cltbld', 16:14:12 INFO - 'LANG': 'en_US.UTF-8', 16:14:12 INFO - 'LANGUAGE': 'en_US:en', 16:14:12 INFO - 'LOGNAME': 'cltbld', 16:14:12 INFO - 'MAIL': '/var/mail/cltbld', 16:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:12 INFO - 'MOZ_NO_REMOTE': '1', 16:14:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:12 INFO - 'NO_EM_RESTART': '1', 16:14:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:12 INFO - 'PWD': '/builds/slave/test', 16:14:12 INFO - 'SHELL': '/bin/bash', 16:14:12 INFO - 'SHLVL': '1', 16:14:12 INFO - 'TERM': 'linux', 16:14:12 INFO - 'TMOUT': '86400', 16:14:12 INFO - 'USER': 'cltbld', 16:14:12 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818', 16:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:12 INFO - '_': '/tools/buildbot/bin/python'} 16:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:12 INFO - Downloading/unpacking psutil>=3.1.1 16:14:12 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:14:12 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:14:12 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:14:12 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:14:12 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:14:12 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:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:14:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:14 INFO - Installing collected packages: psutil 16:14:14 INFO - Running setup.py install for psutil 16:14:14 INFO - building 'psutil._psutil_linux' extension 16:14:14 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:14:14 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:14:14 INFO - building 'psutil._psutil_posix' extension 16:14:14 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:14:14 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:14:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:15 INFO - Successfully installed psutil 16:14:15 INFO - Cleaning up... 16:14:15 INFO - Return code: 0 16:14:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:14: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:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f586a317f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3090>, '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 0x1ce69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6e40>, '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': '826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818', '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:14: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:14: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 mozsystemmonitor==0.3 16:14:15 INFO - Using env: {'DISPLAY': ':0', 16:14:15 INFO - 'HOME': '/home/cltbld', 16:14:15 INFO - 'LANG': 'en_US.UTF-8', 16:14:15 INFO - 'LANGUAGE': 'en_US:en', 16:14:15 INFO - 'LOGNAME': 'cltbld', 16:14:15 INFO - 'MAIL': '/var/mail/cltbld', 16:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:15 INFO - 'MOZ_NO_REMOTE': '1', 16:14:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:15 INFO - 'NO_EM_RESTART': '1', 16:14:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:15 INFO - 'PWD': '/builds/slave/test', 16:14:15 INFO - 'SHELL': '/bin/bash', 16:14:15 INFO - 'SHLVL': '1', 16:14:15 INFO - 'TERM': 'linux', 16:14:15 INFO - 'TMOUT': '86400', 16:14:15 INFO - 'USER': 'cltbld', 16:14:15 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818', 16:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:15 INFO - '_': '/tools/buildbot/bin/python'} 16:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:14: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:14: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:14: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:14: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:14: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:14: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:14:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:14:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:14:17 INFO - Installing collected packages: mozsystemmonitor 16:14:17 INFO - Running setup.py install for mozsystemmonitor 16:14:17 INFO - Successfully installed mozsystemmonitor 16:14:17 INFO - Cleaning up... 16:14:17 INFO - Return code: 0 16:14:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:17 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 0x7f586a317f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3090>, '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 0x1ce69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6e40>, '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': '826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818', '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:14:17 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:14:17 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:14:17 INFO - Using env: {'DISPLAY': ':0', 16:14:17 INFO - 'HOME': '/home/cltbld', 16:14:17 INFO - 'LANG': 'en_US.UTF-8', 16:14:17 INFO - 'LANGUAGE': 'en_US:en', 16:14:17 INFO - 'LOGNAME': 'cltbld', 16:14:17 INFO - 'MAIL': '/var/mail/cltbld', 16:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:17 INFO - 'MOZ_NO_REMOTE': '1', 16:14:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:17 INFO - 'NO_EM_RESTART': '1', 16:14:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:17 INFO - 'PWD': '/builds/slave/test', 16:14:17 INFO - 'SHELL': '/bin/bash', 16:14:17 INFO - 'SHLVL': '1', 16:14:17 INFO - 'TERM': 'linux', 16:14:17 INFO - 'TMOUT': '86400', 16:14:17 INFO - 'USER': 'cltbld', 16:14:17 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818', 16:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:17 INFO - '_': '/tools/buildbot/bin/python'} 16:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:17 INFO - Downloading/unpacking jsonschema==2.5.1 16:14: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:14: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:14: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:14: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:14: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:14: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:14:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:14:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:19 INFO - Downloading functools32-3.2.3-2.tar.gz 16:14:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:14:19 INFO - warning: no files found matching '*.txt' 16:14:19 INFO - no previously-included directories found matching 'build' 16:14:19 INFO - no previously-included directories found matching 'dist' 16:14:19 INFO - no previously-included directories found matching '.git*' 16:14:19 INFO - Installing collected packages: jsonschema, functools32 16:14:19 INFO - Running setup.py install for functools32 16:14:19 INFO - warning: no files found matching '*.txt' 16:14:19 INFO - no previously-included directories found matching 'build' 16:14:19 INFO - no previously-included directories found matching 'dist' 16:14:19 INFO - no previously-included directories found matching '.git*' 16:14:19 INFO - Successfully installed jsonschema functools32 16:14:19 INFO - Cleaning up... 16:14:20 INFO - Return code: 0 16:14:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:20 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 0x7f586a317f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3090>, '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 0x1ce69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6e40>, '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': '826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818', '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:14:20 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:14:20 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:14:20 INFO - Using env: {'DISPLAY': ':0', 16:14:20 INFO - 'HOME': '/home/cltbld', 16:14:20 INFO - 'LANG': 'en_US.UTF-8', 16:14:20 INFO - 'LANGUAGE': 'en_US:en', 16:14:20 INFO - 'LOGNAME': 'cltbld', 16:14:20 INFO - 'MAIL': '/var/mail/cltbld', 16:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:20 INFO - 'MOZ_NO_REMOTE': '1', 16:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:20 INFO - 'NO_EM_RESTART': '1', 16:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:20 INFO - 'PWD': '/builds/slave/test', 16:14:20 INFO - 'SHELL': '/bin/bash', 16:14:20 INFO - 'SHLVL': '1', 16:14:20 INFO - 'TERM': 'linux', 16:14:20 INFO - 'TMOUT': '86400', 16:14:20 INFO - 'USER': 'cltbld', 16:14:20 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818', 16:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:20 INFO - '_': '/tools/buildbot/bin/python'} 16:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:14:20 INFO - Cleaning up... 16:14:20 INFO - Return code: 0 16:14:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:20 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 0x7f586a317f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3090>, '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 0x1ce69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6e40>, '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': '826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818', '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:14:20 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:14:20 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:14:20 INFO - Using env: {'DISPLAY': ':0', 16:14:20 INFO - 'HOME': '/home/cltbld', 16:14:20 INFO - 'LANG': 'en_US.UTF-8', 16:14:20 INFO - 'LANGUAGE': 'en_US:en', 16:14:20 INFO - 'LOGNAME': 'cltbld', 16:14:20 INFO - 'MAIL': '/var/mail/cltbld', 16:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:20 INFO - 'MOZ_NO_REMOTE': '1', 16:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:20 INFO - 'NO_EM_RESTART': '1', 16:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:20 INFO - 'PWD': '/builds/slave/test', 16:14:20 INFO - 'SHELL': '/bin/bash', 16:14:20 INFO - 'SHLVL': '1', 16:14:20 INFO - 'TERM': 'linux', 16:14:20 INFO - 'TMOUT': '86400', 16:14:20 INFO - 'USER': 'cltbld', 16:14:20 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818', 16:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:20 INFO - '_': '/tools/buildbot/bin/python'} 16:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:20 INFO - Downloading/unpacking blobuploader==1.2.4 16:14: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:14: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:14: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:14: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:14: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:14: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:14:22 INFO - Downloading blobuploader-1.2.4.tar.gz 16:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:14:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:14:22 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:14:22 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:14:22 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:14:22 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:14:22 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:14:22 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:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:14:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:14:22 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:14:22 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:14:22 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:14:22 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:14:22 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:14:22 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:14:23 INFO - Downloading docopt-0.6.1.tar.gz 16:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:14:23 INFO - Installing collected packages: blobuploader, requests, docopt 16:14:23 INFO - Running setup.py install for blobuploader 16:14:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:14:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:14:23 INFO - Running setup.py install for requests 16:14:23 INFO - Running setup.py install for docopt 16:14:23 INFO - Successfully installed blobuploader requests docopt 16:14:23 INFO - Cleaning up... 16:14:23 INFO - Return code: 0 16:14:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:23 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 0x7f586a317f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3090>, '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 0x1ce69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6e40>, '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': '826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818', '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:14:23 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:14:23 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:14:23 INFO - Using env: {'DISPLAY': ':0', 16:14:23 INFO - 'HOME': '/home/cltbld', 16:14:23 INFO - 'LANG': 'en_US.UTF-8', 16:14:23 INFO - 'LANGUAGE': 'en_US:en', 16:14:23 INFO - 'LOGNAME': 'cltbld', 16:14:23 INFO - 'MAIL': '/var/mail/cltbld', 16:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:23 INFO - 'MOZ_NO_REMOTE': '1', 16:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:23 INFO - 'NO_EM_RESTART': '1', 16:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:23 INFO - 'PWD': '/builds/slave/test', 16:14:23 INFO - 'SHELL': '/bin/bash', 16:14:23 INFO - 'SHLVL': '1', 16:14:23 INFO - 'TERM': 'linux', 16:14:23 INFO - 'TMOUT': '86400', 16:14:23 INFO - 'USER': 'cltbld', 16:14:23 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818', 16:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:23 INFO - '_': '/tools/buildbot/bin/python'} 16:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:14:23 INFO - Running setup.py (path:/tmp/pip-Y3M9wC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:14:24 INFO - Running setup.py (path:/tmp/pip-H_Fxvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:14:24 INFO - Running setup.py (path:/tmp/pip-PgeOeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:14:24 INFO - Running setup.py (path:/tmp/pip-BWBrOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:14:24 INFO - Running setup.py (path:/tmp/pip-7hueEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:14:24 INFO - Running setup.py (path:/tmp/pip-7y4P3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:14:24 INFO - Running setup.py (path:/tmp/pip-jiuqGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:14:24 INFO - Running setup.py (path:/tmp/pip-wDITnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:14:24 INFO - Running setup.py (path:/tmp/pip-QEopgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:14:24 INFO - Running setup.py (path:/tmp/pip-MGyaRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:14:24 INFO - Running setup.py (path:/tmp/pip-pTG0tW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:14:24 INFO - Running setup.py (path:/tmp/pip-uHVm2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:14:24 INFO - Running setup.py (path:/tmp/pip-QiIXmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:14:24 INFO - Running setup.py (path:/tmp/pip-0je0wS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:24 INFO - Running setup.py (path:/tmp/pip-C0ET56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:14:25 INFO - Running setup.py (path:/tmp/pip-rCN23V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:14:25 INFO - Running setup.py (path:/tmp/pip-C_OFwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:14:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:14:25 INFO - Running setup.py install for manifestparser 16:14:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:14:25 INFO - Running setup.py install for mozcrash 16:14:25 INFO - Running setup.py install for mozdebug 16:14:25 INFO - Running setup.py install for mozdevice 16:14:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:14:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:14:25 INFO - Running setup.py install for mozfile 16:14:25 INFO - Running setup.py install for mozhttpd 16:14:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:14:25 INFO - Running setup.py install for mozinfo 16:14:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:14:25 INFO - Running setup.py install for mozInstall 16:14:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:14:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:14:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:14:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:14:25 INFO - Running setup.py install for mozleak 16:14:26 INFO - Running setup.py install for mozlog 16:14:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:14:26 INFO - Running setup.py install for moznetwork 16:14:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:14:26 INFO - Running setup.py install for mozprocess 16:14:26 INFO - Running setup.py install for mozprofile 16:14:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:14:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:14:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:14:26 INFO - Running setup.py install for mozrunner 16:14:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:14:26 INFO - Running setup.py install for mozscreenshot 16:14:26 INFO - Running setup.py install for moztest 16:14:26 INFO - Running setup.py install for mozversion 16:14:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:14:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:14:26 INFO - Cleaning up... 16:14:26 INFO - Return code: 0 16:14:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:26 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 0x7f586a317f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3090>, '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 0x1ce69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6e40>, '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': '826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818', '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:14:26 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:14:26 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:14:26 INFO - Using env: {'DISPLAY': ':0', 16:14:26 INFO - 'HOME': '/home/cltbld', 16:14:26 INFO - 'LANG': 'en_US.UTF-8', 16:14:26 INFO - 'LANGUAGE': 'en_US:en', 16:14:26 INFO - 'LOGNAME': 'cltbld', 16:14:26 INFO - 'MAIL': '/var/mail/cltbld', 16:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:26 INFO - 'MOZ_NO_REMOTE': '1', 16:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:26 INFO - 'NO_EM_RESTART': '1', 16:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:26 INFO - 'PWD': '/builds/slave/test', 16:14:26 INFO - 'SHELL': '/bin/bash', 16:14:26 INFO - 'SHLVL': '1', 16:14:26 INFO - 'TERM': 'linux', 16:14:26 INFO - 'TMOUT': '86400', 16:14:26 INFO - 'USER': 'cltbld', 16:14:26 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818', 16:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:26 INFO - '_': '/tools/buildbot/bin/python'} 16:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:14:27 INFO - Running setup.py (path:/tmp/pip-FNA394-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:14:27 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:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:14:27 INFO - Running setup.py (path:/tmp/pip-dDFir2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:14:27 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:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:14:27 INFO - Running setup.py (path:/tmp/pip-j7Ryht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:14:27 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:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:14:27 INFO - Running setup.py (path:/tmp/pip-e2136Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:14:27 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:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:14:27 INFO - Running setup.py (path:/tmp/pip-75vfV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:14:27 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:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:14:27 INFO - Running setup.py (path:/tmp/pip-HbMeQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:14:27 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:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:14:27 INFO - Running setup.py (path:/tmp/pip-Xs6RYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:14:27 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:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:14:27 INFO - Running setup.py (path:/tmp/pip-aEIOEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:14:27 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:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:14:27 INFO - Running setup.py (path:/tmp/pip-kuyMAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:14:27 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:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:14:27 INFO - Running setup.py (path:/tmp/pip-aPGdyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:14:27 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:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:14:27 INFO - Running setup.py (path:/tmp/pip-rOeep1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:14:27 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:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:14:27 INFO - Running setup.py (path:/tmp/pip-QARhIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:14:28 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:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:14:28 INFO - Running setup.py (path:/tmp/pip-UUupUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:14:28 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:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:14:28 INFO - Running setup.py (path:/tmp/pip-N3xfs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:14:28 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:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:28 INFO - Running setup.py (path:/tmp/pip-cgNV5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:28 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:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:14:28 INFO - Running setup.py (path:/tmp/pip-7k9n9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:14:28 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:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:14:28 INFO - Running setup.py (path:/tmp/pip-qtBn3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:14:28 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:14:28 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:14:28 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:14:28 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:14:28 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:14:28 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:14:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:14:28 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:14:28 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:14:28 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:14:28 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:14:28 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:14:28 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:14:30 INFO - Downloading blessings-1.6.tar.gz 16:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:14:30 INFO - Installing collected packages: blessings 16:14:30 INFO - Running setup.py install for blessings 16:14:30 INFO - Successfully installed blessings 16:14:30 INFO - Cleaning up... 16:14:30 INFO - Return code: 0 16:14:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:14:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:14:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:14:30 INFO - Reading from file tmpfile_stdout 16:14:30 INFO - Current package versions: 16:14:30 INFO - argparse == 1.2.1 16:14:30 INFO - blessings == 1.6 16:14:30 INFO - blobuploader == 1.2.4 16:14:30 INFO - docopt == 0.6.1 16:14:30 INFO - functools32 == 3.2.3-2 16:14:30 INFO - jsonschema == 2.5.1 16:14:30 INFO - manifestparser == 1.1 16:14:30 INFO - mozInstall == 1.12 16:14:30 INFO - mozcrash == 0.17 16:14:30 INFO - mozdebug == 0.1 16:14:30 INFO - mozdevice == 0.48 16:14:30 INFO - mozfile == 1.2 16:14:30 INFO - mozhttpd == 0.7 16:14:30 INFO - mozinfo == 0.9 16:14:30 INFO - mozleak == 0.1 16:14:30 INFO - mozlog == 3.3 16:14:30 INFO - moznetwork == 0.27 16:14:30 INFO - mozprocess == 0.23 16:14:30 INFO - mozprofile == 0.28 16:14:30 INFO - mozrunner == 6.12 16:14:30 INFO - mozscreenshot == 0.1 16:14:30 INFO - mozsystemmonitor == 0.3 16:14:30 INFO - moztest == 0.7 16:14:30 INFO - mozversion == 1.4 16:14:30 INFO - psutil == 3.1.1 16:14:30 INFO - requests == 1.2.3 16:14:30 INFO - wsgiref == 0.1.2 16:14:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:30 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 0x7f586a317f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3090>, '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 0x1ce69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6e40>, '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': '826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818', '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:14:30 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:14:30 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:14:30 INFO - Using env: {'DISPLAY': ':0', 16:14:30 INFO - 'HOME': '/home/cltbld', 16:14:30 INFO - 'LANG': 'en_US.UTF-8', 16:14:30 INFO - 'LANGUAGE': 'en_US:en', 16:14:30 INFO - 'LOGNAME': 'cltbld', 16:14:30 INFO - 'MAIL': '/var/mail/cltbld', 16:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:30 INFO - 'MOZ_NO_REMOTE': '1', 16:14:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:30 INFO - 'NO_EM_RESTART': '1', 16:14:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:30 INFO - 'PWD': '/builds/slave/test', 16:14:30 INFO - 'SHELL': '/bin/bash', 16:14:30 INFO - 'SHLVL': '1', 16:14:30 INFO - 'TERM': 'linux', 16:14:30 INFO - 'TMOUT': '86400', 16:14:30 INFO - 'USER': 'cltbld', 16:14:30 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818', 16:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:30 INFO - '_': '/tools/buildbot/bin/python'} 16:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:30 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:14:30 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:14:30 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:14:30 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:14:30 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:14:30 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:14:30 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:14:30 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:14:30 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:14:30 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:14:30 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:14:30 INFO - Cleaning up... 16:14:31 INFO - Return code: 0 16:14:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f586a317f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3090>, '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 0x1ce69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6e40>, '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': '826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818', '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:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:14:31 INFO - Using env: {'DISPLAY': ':0', 16:14:31 INFO - 'HOME': '/home/cltbld', 16:14:31 INFO - 'LANG': 'en_US.UTF-8', 16:14:31 INFO - 'LANGUAGE': 'en_US:en', 16:14:31 INFO - 'LOGNAME': 'cltbld', 16:14:31 INFO - 'MAIL': '/var/mail/cltbld', 16:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:31 INFO - 'MOZ_NO_REMOTE': '1', 16:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:31 INFO - 'NO_EM_RESTART': '1', 16:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:31 INFO - 'PWD': '/builds/slave/test', 16:14:31 INFO - 'SHELL': '/bin/bash', 16:14:31 INFO - 'SHLVL': '1', 16:14:31 INFO - 'TERM': 'linux', 16:14:31 INFO - 'TMOUT': '86400', 16:14:31 INFO - 'USER': 'cltbld', 16:14:31 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818', 16:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:31 INFO - '_': '/tools/buildbot/bin/python'} 16:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:14:31 INFO - Cleaning up... 16:14:31 INFO - Return code: 0 16:14:31 INFO - Running post-action listener: _resource_record_post_action 16:14:31 INFO - Running post-action listener: _start_resource_monitoring 16:14:31 INFO - Starting resource monitoring. 16:14:31 INFO - [mozharness: 2016-08-21 23:14:31.256342Z] Finished create-virtualenv step (success) 16:14:31 INFO - [mozharness: 2016-08-21 23:14:31.256821Z] Running install step. 16:14:31 INFO - Running pre-action listener: _resource_record_pre_action 16:14:31 INFO - Running main action method: install 16:14:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:14:31 INFO - Reading from file tmpfile_stdout 16:14:31 INFO - Detecting whether we're running mozinstall >=1.0... 16:14:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:14:31 INFO - Reading from file tmpfile_stdout 16:14:31 INFO - Output received: 16:14:31 INFO - Usage: mozinstall [options] installer 16:14:31 INFO - Options: 16:14:31 INFO - -h, --help show this help message and exit 16:14:31 INFO - -d DEST, --destination=DEST 16:14:31 INFO - Directory to install application into. [default: 16:14:31 INFO - "/builds/slave/test"] 16:14:31 INFO - --app=APP Application being installed. [default: firefox] 16:14:31 INFO - mkdir: /builds/slave/test/build/application 16:14:31 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:14:31 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:14:48 INFO - Reading from file tmpfile_stdout 16:14:48 INFO - Output received: 16:14:48 INFO - /builds/slave/test/build/application/firefox/firefox 16:14:48 INFO - Running post-action listener: _resource_record_post_action 16:14:48 INFO - [mozharness: 2016-08-21 23:14:48.617269Z] Finished install step (success) 16:14:48 INFO - [mozharness: 2016-08-21 23:14:48.617515Z] Running run-tests step. 16:14:48 INFO - Running pre-action listener: _resource_record_pre_action 16:14:48 INFO - Running main action method: run_tests 16:14:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:14:48 INFO - Python 2.7.3 16:14:48 INFO - Return code: 0 16:14:48 INFO - grabbing minidump binary from tooltool 16:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:48 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3090>, '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 0x1ce69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:14:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:14:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:14:48 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:14:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:14:48 INFO - Return code: 0 16:14:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:14:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:14:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:14:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:14:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:14:48 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/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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:14:48 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/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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:14:48 INFO - Using env: {'DISPLAY': ':0', 16:14:48 INFO - 'HOME': '/home/cltbld', 16:14:48 INFO - 'LANG': 'en_US.UTF-8', 16:14:48 INFO - 'LANGUAGE': 'en_US:en', 16:14:48 INFO - 'LOGNAME': 'cltbld', 16:14:48 INFO - 'MAIL': '/var/mail/cltbld', 16:14:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:14:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:48 INFO - 'MOZ_NO_REMOTE': '1', 16:14:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:48 INFO - 'NO_EM_RESTART': '1', 16:14:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:48 INFO - 'PWD': '/builds/slave/test', 16:14:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:14:48 INFO - 'SHELL': '/bin/bash', 16:14:48 INFO - 'SHLVL': '1', 16:14:48 INFO - 'TERM': 'linux', 16:14:48 INFO - 'TMOUT': '86400', 16:14:48 INFO - 'USER': 'cltbld', 16:14:48 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818', 16:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:48 INFO - '_': '/tools/buildbot/bin/python'} 16:14:48 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/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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:14:48 INFO - mozversion application_buildid: 20160821133003 16:14:48 INFO - mozversion application_changeset: f823117225343b73be4df1ee89c904580d66d148 16:14:48 INFO - mozversion application_display_name: Nightly 16:14:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:14:48 INFO - mozversion application_name: Firefox 16:14:48 INFO - mozversion application_remotingname: firefox 16:14:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:14:48 INFO - mozversion application_vendor: Mozilla 16:14:48 INFO - mozversion application_version: 51.0a1 16:14:48 INFO - mozversion platform_buildid: 20160821133003 16:14:48 INFO - mozversion platform_changeset: f823117225343b73be4df1ee89c904580d66d148 16:14:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:14:48 INFO - mozversion platform_version: 51.0a1 16:14:48 INFO - using testdate: 1471821288 16:14:48 INFO - actual date: 1471821288 16:14:48 INFO - starting webserver on 'localhost:37406' 16:14:48 INFO - SUITE-START | Running 2 tests 16:14:48 INFO - TEST-START | dromaeo_css 16:14:48 INFO - operating with platform_type : linux_ 16:14:48 INFO - Initialising browser for dromaeo_css test... 16:14:48 INFO - TEST-INFO | started process 15411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFHtjWI/profile http://localhost:37406/getInfo.html) 16:14:53 INFO - PROCESS | 15411 | __metrics Screen width/height:1600/1200 16:14:53 INFO - PROCESS | 15411 | colorDepth:24 16:14:53 INFO - PROCESS | 15411 | Browser inner width/height: 1024/697 16:14:53 INFO - PROCESS | 15411 | __metrics 16:14:54 ERROR - PROCESS | 15411 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2993: TypeError: this.tabs is undefined 16:14:55 INFO - TEST-INFO | 15411: exit 0 16:14:55 INFO - Browser initialized. 16:14:55 INFO - Running cycle 1/1 for dromaeo_css test... 16:14:55 INFO - TEST-INFO | started process 15530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFHtjWI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:15:07 INFO - PROCESS | 15530 | RSS: Main: 186597376 16:15:07 INFO - PROCESS | 15530 | 16:15:57 INFO - PROCESS | 15530 | 1471821357056 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:18:06 INFO - PROCESS | 15530 | Cycle 1(1): loaded http://localhost:37406/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37406/tests/dromaeo/cssquery-ext.html) 16:18:07 INFO - PROCESS | 15530 | RSS: Main: 198467584 16:18:07 INFO - PROCESS | 15530 | 16:21:09 INFO - PROCESS | 15530 | Cycle 1(1): loaded http://localhost:37406/tests/dromaeo/cssquery-ext.html (next: http://localhost:37406/tests/dromaeo/cssquery-jquery.html) 16:21:10 INFO - PROCESS | 15530 | RSS: Main: 197881856 16:21:10 INFO - PROCESS | 15530 | 16:24:12 INFO - PROCESS | 15530 | Cycle 1(1): loaded http://localhost:37406/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37406/tests/dromaeo/cssquery-mootools.html) 16:24:12 INFO - PROCESS | 15530 | RSS: Main: 198795264 16:24:12 INFO - PROCESS | 15530 | 16:27:14 INFO - PROCESS | 15530 | Cycle 1(1): loaded http://localhost:37406/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37406/tests/dromaeo/cssquery-prototype.html) 16:27:15 INFO - PROCESS | 15530 | RSS: Main: 196235264 16:27:15 INFO - PROCESS | 15530 | 16:30:17 INFO - PROCESS | 15530 | Cycle 1(1): loaded http://localhost:37406/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37406/tests/dromaeo/cssquery-yui.html) 16:30:18 INFO - PROCESS | 15530 | RSS: Main: 198905856 16:30:18 INFO - PROCESS | 15530 | 16:33:21 INFO - PROCESS | 15530 | Cycle 1(1): loaded http://localhost:37406/tests/dromaeo/cssquery-yui.html (next: http://localhost:37406/tests/dromaeo/cssquery-dojo.html) 16:33:21 INFO - PROCESS | 15530 | RSS: Main: 199540736 16:33:21 INFO - PROCESS | 15530 | 16:33:21 INFO - PROCESS | 15530 | __start_tp_report 16:33:21 INFO - PROCESS | 15530 | _x_x_mozilla_page_load 16:33:21 INFO - PROCESS | 15530 | _x_x_mozilla_page_load_details 16:33:21 INFO - PROCESS | 15530 | |i|pagename|runs| 16:33:21 INFO - PROCESS | 15530 | |0;dojo.html;3036.635603727553;3070.9405255186953;3090.995426486391;3098.5816914716506;3100.8914687985925;5376.381716102649;5486.862828429286;5550.583706222029;5571.303587051619;5581.274434323537;5381.515663590276;5426.321709786277;5432.402435732066;5487.2317875497465;5493.7802487900435;4773.665843390964;4989.850304490871;5016.874578135539;5074.923876141861;5085.110105731501;5015.724135172564;5027.170516864713;5033.974830125844;5082.771275292602;5097.617678674096;4822.927656085161;4850.830220942268;4900.0199960007785;4927.6550641455115;5026.271190677331;4988.600911927074;4999.650024498286;5013.398392192924;5014.498550144993;5016.8996620067755;4942.629302802268;4981.676191047571;5004.199328107522;5008.474110218411;5014.147594908838;5368.275282836845;5377.46225377463;5413.972930135364;5469.917951230735;5492.835214943558;5888.823335299905;5897.705114744289;5900.262467191601;5902.498287645555;5906.26171728534;5797;5944.197533333031;5946.375630558772;5948.7620495180145;5960;5474.863128421782;5490.752916118744;5501.5323697485765;5573.526250268773;5574.693391863487;6112.877742445126;6116.2048933639235;6120.112583675342;6128.969355153285;6133.233345831771;5606.831795046155;5851.239338886003;5873.647581145145;5876.265466816648;5878.353381128158;5743.684097374685;5798.536117110621;5809.186713860063;5852;5854.063349864001;5756;5839.386864379264;5891.3224979127945;5933.732982015819;5939.07944268639;5920.526357891445;5933.3473317934995;5935.287765468085;5955.225820643289;5958.225430693982;4444.177827101997;4476.686631935799;4493.640508759357;4509.481409637868;4556.681032327771;4011.3180759270995;4023.637872591481;4038.374052021941;4039.171969746195;4041.3937909313836;5528.640638358494;5555.111182210827;5576.219329293902;5578.804741834017;5581.107022876401;5840.474357307863;5853.590248682552;5858.297004359419;5903.852403689943;5956.374580669054;5610.551155907518;5671.6597004179885;5682.801101961411;5685.914711279334;5694.9430505695245;5150.871228219325;5162.09663308927;5175.327207463081;5180.300659411007;5183;5929.555283353766;6034.668093254913;6088.695565221721;6104.908426373519;6150.954337762681;5951.970240148771;5974.342822289458;5978.133170690313;5980.013297805987;5983.790567330297;6133.8466538335115;6152.969235153795;6166.568340216142;6180.783672571439;6184.412480814315;5507.146392309039;5740.856478587902;5790.9420905792085;5808.680522571299;5888.440598143169;5952.315483719428;5969.343372229138;5988.880222395441;5999.040153575407;5999.160117583455;5821.854453638693;5828.795992140254;5832;5833.562482813721;5835.912461312999;5591.412901645269;5659.943400565941;5682.318121825408;5691.487766100905;5775.566832487496;5677.460641239076;5691.686957217393;5692.430756924275;5695.686737229492;5698.800541981011;5756.165356023437;5780.21967034445;5781.364049954417;5824.592278540462;5829.242198514166;5508.394076651485;5600.887982240414;5623.943760562342;5635.380108188178;5731.942680573141 16:33:21 INFO - PROCESS | 15530 | |1;ext.html;555.1783360626274;560.7280468972548;560.9146301905813;561.4469747298913;614.4439282449384;39284.2143157137;43491;43540.78229608852;43668.563314366846;43813;42873.57126428735;43484.13031739363;43530.564694353045;43530.7823460883;43984;8892.8666070009;8908.777280567972;9050.592723327467;9058.909410905873;9070.954645226764;8933.24067454264;8977.416467929595;8985.685501007467;9007.144321289466;9024.052474490183;9011.504367259799;9041.050689677555;9042;9053.683121090764;9088.909110908906;8929.821403571892;8977.86533201996;8982.640694372218;8990.05604411534;9016.729498115066;8863;8873.778155546099;8948.284137269004;8953.462792232487;8959.552022398853;40274.39588406176;41066.38400423996;41143.1771364574;41233.58766412357;41329.586704132875;3476.652334766503;3725.1059745660846;3861.4787003754413;3961.7821019843896;4215.957840421587;31600;31969.84015079933;32293.51559726606;32328.838355808304;34146.48780268298;4091.8363265469347;4131.566185550534;4204.1801848639225;4243.830246790125;4313.309870420749;262177;262220;262924.6853765738;263327;264202;35312.82343588266;57504.137437938465;57700.99999999916;57755;57837;36406.81796591053;38195;38374.80812595975;38377.42433863494;38387.61612383896;14125.081869678643;14321.14073155614;14335;14363.928180359031;14393.78409323861;11800.940995294968;11836.88163118375;11870.584529541424;11907.702307442383;11986.64040078799;8532.317414606816;8639.222469977733;8689.478631282143;8737.257333126629;8763.386562940661;3330.200751819594;3389.1357703785375;3392.830358482066;3405.625381208065;3411.1642647551507;931.4085555672197;969.8981606931312;1074.5325783284297;1113.8106521891298;1151.7926773180907;29020.564691529646;29103.56344654832;29126.41747165087;29497.557536636967;29524.933254672396;1076.6931424544125;1081.4700796609761;1085.2132204152085;1158.073541167063;1166.3468457663735;14366;15046.172460514777;15135.697286054217;15176.696466070616;15396.23018849053;625239;629639;630813;632252;635989;58794.7060264696;59167.70416147892;59351;59458.40541594615;59793.701031494566;1286.9420876060599;1313.507434711983;1358.456617353047;1367.500862185315;1370.6436326554967;26799.86600066987;28478.57932075714;28716.569251461664;28922.214408114145;29496.262593435335;51794.48205517897;51811.15038672758;51818.48181518137;51971.2204316928;52211;493740;493764;494827;495944;502293;28089.77575974831;28898.27754306159;29040.12879613615;29209.85395073011;29222.707772922;48260.75869620629;48428.03143937031;48741.75629121832;49477.25784113169;49565.25652115149;40662.79668601638;40751.79624101861;40855.795721021204;41509.79245103755;42637.786811065744;40232.195356093296;41191.588084118775;41341.793291033355;42101.36847947222;42664.78667606642;35527;36097.81951090228;36308;37431;39144.41283380695;33216.33567328592;37047.25905481821;38030.049248769;38200.42699359456;38968;25378.873105634353;26016.479670406865;26889.596656050566;27364.315892102855;27663.30841728973 16:33:21 INFO - PROCESS | 15530 | |2;jquery.html;368.78241837315994;384.1491097219659;385.31606398642407;394.92693851637466;407.74515927545286;17903.820961790378;19854;20156.59686806263;20159.697604535944;20177.596448071028;17541.64916701665;17828.1977311021;17987.910060449678;20539.178432862704;21066.262680806176;6024.879502409949;6355.936440635593;6618.073469714244;6638.103855979453;6643.501737369693;6496.382843629847;6543.443807276387;6555.3772391622715;6575.441087507567;6579.04603832444;6377.585456945307;6546.4762818974605;6563.737450501974;6584.572002819826;6603.471722262231;6517.869642607145;6600.4389626881775;6601.834954126161;7302.1967583565765;7672.73145439907;7233.421326293884;7521.4358923080445;7524;7540.359069479101;7555.5088919220625;26055.478890422273;26060.218193454228;27010.5948410774;27020.72979270202;27255.727442725518;2615.712271650136;2644.8413095214155;2710.6611673540806;2720.455908818244;2730.4675588260297;15640.765388519181;15975.920120399323;16222.83777162237;16715.83284167155;17166.313347466086;2087.926922557703;2117.2589593642256;2121.819645330149;2174.836887233448;2201.2955854126685;90193;90551.54724226403;93063.53468232615;93515;93864.06135938622;17386.391476298522;17444.91277543604;17579.29682812673;18161.7275740864;19471.318503852297;30988.53517197244;31025.689743102732;31085.22286942799;31207;31486.842565787483;9126.908730912739;9374.62501499946;9551.379160354554;9565.904340956502;9890.60437582503;7728.343090837229;7940.682372705142;8123.4313598047565;8177.79555511117;8216.83566328682;8340.37447191463;8672.184238934975;8891.688790892287;8971.551422428984;9052.185303322733;3386.6274709781906;3444.4488881778793;3535.911602209965;3653.606887488646;3667.7249206309634;882.4131952251809;903.1871315815819;977.63827383867;984.4437892590663;1043.888259004158;17328.747262855748;17945.910270448563;18063.72904406435;18172.27310907575;18650.813491865178;966.4925913895261;985.2413641496152;991.4348821171862;995.9651412200539;1027.275770581738;9497.097775711296;10180.440075795754;10219.489025548693;10343.4311112888;10382.688519344432;491500;492997;494440;501969;509036;93902;94665;94994;95809.52095239479;96180.51909740406;998.1665309466531;1039.812833689943;1043.645160645369;1057.846612241236;1065.1319174872608;15386.461473848361;15413.76879346833;15461.768073479132;15953.441629542911;16415.42546010884;40344.3948340781;40425.39361909515;40883.79558102191;41240;41669;57990.42009580019;59231.703841480514;59424.40575594362;60448.39551604604;62773.37226627858;7257;7688.538687678757;8189.754307370788;8276.379271554779;8596.484210947363;12647.241165530098;12912.935435322763;13301.467941282628;13409.396577153857;13418.93290533541;7843.6862525498345;8089.069756978023;8284.50292982423;11210.719732006764;11324;7765.456418050682;8018.398620103632;8276.917230827614;8437.620307086074;8466.195711407407;8316.6673333066;8470.15298470148;8485;8519.275861551838;8640.179182977607;12499.875001249871;12597;12724.109312348417;12844.486220551073;13189.142705724098;11503.654890353302;11565;11927.821082683593;12039.63881083569;12242.693932651398 16:33:21 INFO - PROCESS | 15530 | |3;mootools.html;1444.9855501444988;1497.3411698852503;1625.2523839034043;1714.6913555559995;1755.5084576318627;7928.563928983904;8712.128787121284;8858.645654173826;9546.140847323739;9605.855912161314;8915.286777057836;9269.721908342744;9331.066893310666;9343.43939363637;9376.906230937688;2481.441675622984;2497.825152239344;2508.08454913956;2513.28371414147;2537.8857951392138;2344.8358614896965;2436.9390765230924;2440.2801173653725;2441.8534887906694;2445.498672772086;2446.9755302447015;2447.3392184110367;2448.3879030242438;2455.5211733711935;2463.8275320727557;2381.452265978826;2401.0275838285525;2419.419339358559;2429.7205821330595;2450.2649205238536;2432.5013372258645;2432.647266146399;2433.6349547568007;2439.9390015249583;2456.0175929628112;9378.109079637492;9424.811503769886;9469.573869175903;9574.617015319449;9578.904210957871;5517.724113794295;5650.378458369576;5666.320041595035;5698.458646428583;5716.342620598602;3542.433210686278;3716.3056783831776;3795.278897009587;3798.3542797724454;3822.9044273893096;1067.3062509368895;1132.3375825142302;1144.525022115821;1169.7485040716288;1197.8382918306004;13287.870531004875;13311.534096306583;13317.134386264861;13372.665683357896;13429.865701343057;4811.254255590389;4982.676126051795;5011.298418221452;5092.38891333035;5166.689998600096;11132.888671113185;11245.775084498264;11254.943725281484;11256.887431125584;11268.211225214156;5552.500274975191;5611.298587676541;5612.074007788669;5616.494515493543;5622;4403.471583410012;4809.302651115569;4955.876103097379;5026.824061157915;5083.8983220335385;4064.219041692595;4240.724352917051;4457.064016556495;4462.576055274809;4469.932951005738;1353.2895230004326;1358.1715153756202;1377.0567161494207;1380.7100508893045;1393.171063217384;923.6028507741736;935.2517985611483;940.191435365585;943.056943056943;951.8239125761756;6035.456808887221;6091.299500557404;6136.325004249529;6368.076628888785;6404.679766011774;919.7608621758258;935.1910597333393;984.532347135105;1004.638330201127;1039.417925961464;3997.720159588859;4001.7198796083994;4093.7134400592267;4136.614234231566;4149.232392007489;11465.197436179555;11860.644180674593;11966.521339146511;11986.940065299617;12019.87980120205;11070.723231919266;11508.36703981289;11542.480588373543;11834.76330473403;11869.46587403569;8212.794680133044;8340.833183336421;8396.748097557083;8444.704435344856;8456.196661317164;6060.181875446759;6318.936810632019;6394.200724909387;6496.350364963466;6536.0522724205675;9972.60109595637;10598.25812193139;10797.946010269898;10816.351018938889;10888.128949684165;10472;10814.837777433502;10819.621313253998;10932.672019839418;10965.067969222386;7522.849543009;8140.063892652421;8243.629036693483;8356.832863342821;8541.786455338417;9270.860937085814;9318;9349.111834375723;9358.064193580587;9367.829021372328;7842.72550460754;7962.163972782774;8001.079875814356;8097.635606397608;8146.592670366576;7656.272654097852;7739.380849532136;7741.806454838674;7757.844843102994;7935.841283174189;7116.3951064158055;7197.928020719935;7253.782386528413;7265.600391978492;7282.053333066668;5303.522682958553;5430.891382172255;5467.316585426822;5480.6437581557075;5541.058020136506;5383.946160538345;5384.6499977501335;5442.401335853132;5475.890482190413;5579.358373787067 16:33:21 INFO - PROCESS | 15530 | |4;prototype.html;317.94753865612176;324.81810186295667;329.3643268491811;329.6719763834985;332.61250643000903;5378.1663842104435;5407.729613519318;5576.9163462548095;5633.971830140848;5671.6671582178205;5438.211459338394;5452.228025891591;5472.440354498968;5502.642328248661;5513.3108361454815;4298.527162012192;4309.655227581786;4312.698111132207;4319.503257125431;4324.84863029794;4168.5623009584015;4254.9149017019645;4291.1632231714675;4321.82712691492;4331;4272.124214536013;4278;4295.453636690789;4298.677599180059;4304.956950430487;4303.376010478494;4307.440032795748;4310.116426132635;4310.224159651261;4319.352097185416;3687.2809802088605;3760.9435858462143;3812.4281357796276;3816.694664426867;3843.7117216208617;5346.625736198468;5354.839354819362;5407.594025553384;5415.9458405415835;5427.2361482517945;4869.686898723114;4902.583280421169;4917.459079501252;4931.235658472907;4941.036497882914;5491.807786727485;5655.604107712462;5728.627639203439;5747.6551406915305;5781.421857814227;4073.531543872463;4083.3262511685534;4086.8160932758096;4099.754014759124;4114.855980040684;6040.067178502881;6080.209572755513;6081;6089.786857459968;6137.754489820401;3892.6885849132;4087.529934057562;4243.6605071594195;4266.08279219963;4283.143371325685;4168.458100446983;4178.7283826551175;4180.408146948911;4183.205191013698;4183.560726123713;4811.206150985048;4850.854474365775;4865.5864251538305;4868.9269660955115;4879.658423910292;5621.437856214346;5760.711964401763;5767.942320576741;5854.2974843018255;5888.087346461305;1417.4259424932918;1444.59551325629;1448.992755036218;1450.5213279617913;1451.5935538049152;884.9955750221208;904.5160838951261;924.6024209589806;936.8969413364524;938.2728385501155;4871.171900776805;4887.095887260868;4897;4918.95081049185;4980.477049909779;5159.613029022838;5188.636795424284;5190.247414125006;5192.506711862367;5206.973965130226;4710.3405523226775;4733.526647335308;4900.789982561428;4922.876928076755;4945.554900059012;2728.331558768075;2749.5188342040065;2756.415061339698;2767.405007923306;2787.6376071110626;5269.71016594091;5330.8933821324135;5337.879045400509;5350.892982140335;5402.621816472809;5021.774020169101;5305.681659100466;5341.545968592635;5348.839534813962;5349.812756553502;5372.274742909657;5372.677639341652;5376.973115134399;5378.489043540857;5389.649672771179;5181.3782346118705;5200.59583912334;5207.6875387476875;5256.474352564713;5287.762050707651;5213.296205012275;5469.671819690831;5863.765449381977;5901.986649078496;5917.615355001911;6187.412195841388;6193;6223.906641400473;6245.68771561411;6247.344028877084;3896.941545876871;4138.461999939988;4146.79266036703;4153.169366126847;4163.708540402143;5725.856853578527;5888.381719919518;5903.527717782653;5904.261967254093;5949.434803693643;5781.653100813965;5795;5795.24661793981;5798.289504596239;5804.158397032322;5769.663286369027;5769.91345129815;5788.450097240755;5793.91309130355;5859.531237501075;5580.441955804549;5631.943680563306;5723.828285151452;5743.971280143573;5768.788554403623;5830.300363956352;5845.620034697731;5866.266716660418;5898.233229680114;5924.52603791687;5646.407127251744;5665.943340566541;5714.628489162654;5766.769329226784;5774.48029677331 16:33:21 INFO - PROCESS | 15530 | |5;yui.html;738.6085374751382;783.2441693765516;784.4665627373388;822.0751654388813;851.659336265494;15187.392504299829;16268.105254211014;16426;16463.09452980084;16513.091779952098;14744.557663270092;14850.33173507192;14884.404623815062;14905;14923.253837308119;796.4743269442184;805.8025783683006;808.8786681997689;812.8780682897553;843.3464065349373;832.2177153475744;835.8453686068067;835.9540225287607;836.3685417509772;837.1795640272536;865.8095219051798;868.3747701654798;871.8561437362828;872.5462759365126;873.5719497446237;867.1371984875058;871.5119533061475;873.6243415331405;875.4353442029919;875.4747151708988;626.8777588370269;629.0469938043867;631.5421319543341;632.7690393006519;634.9238091429058;14410.927945360207;14411.639709007253;14415;14456.855431445656;14497.202653854034;14112.576622701336;14224.573262802132;14233.430662773477;14431.927840360837;14464.421423143061;12450.3152326622;12531.561395351118;12582;12628.17916835412;13304.06871518994;3550;3682.5949145593963;3716.981415092934;3742.101895545077;3742.700583953277;90247.54876225643;91268.54365728129;93399.53300233523;93677.53161234218;94826;10895.782084358269;11169.329840209452;11208;11323.263987840764;11499.655010349703;21419.357419277447;21538.13847446116;21657.241996530047;21704.240351587618;21750.782492175193;7821.687132514636;7894.171112033268;8213.95893020531;8359.874601880976;8418.326533877274;4563.224251877189;4664.673472856935;4666.533346665306;4716.434027916604;4719.716816990923;3428.8628454861528;3519.8416071276856;3523.982380088083;3528.100334414708;3553.9466907996402;559.3427722426133;594.2007999241014;605.1890466774455;612.5895649914568;623.5354660777749;573.3062993777493;622.8723111762077;655.8324736745103;659.8623545043289;692.4944790303007;8766.167214114648;9001.054889236666;9126.315526335551;9373.859392109123;9573.425594464215;507.7994192294023;593.1606776411415;622.5610944284268;654.9279579246279;672.7712577723597;4020.798960051986;4044.0698639313123;4110.547839737626;4194.769287689206;4208.642265407413;72419.63790181016;119440.40279798546;121423;129143;134060;31043.223919402197;50519.494805052214;62969.74060518764;65515.344846551874;103742.48128759308;93202;93588.53205733928;94491.0550894496;95017.524912375;96157.5192124035;7963.283304502623;8060.395470339865;8109.7161599343735;8225.876611850947;8272.420930534805;54477.72761136169;54534;54599.18101228564;56791;59104.704476477345;73959.26040739524;75198;83900.58049709712;83940.58029709812;84544.57727711322;12071.275723456622;12359.3820308986;12368.690782730504;12774.61676149717;12943.5469758558;14559.490417835324;14955.551333460013;14971;15349.21776213053;15495.612609684396;12335.383230838243;13116.868831311947;14427.3507692152;14708.55874323772;14865.554033379016;12697.619071427873;13266.33668316561;13268.601941941757;14596.921730830281;14674.779878302048;14193;14236.572902812932;14262.42950281977;14527.854721453074;14544.418223271374;10210.897891021292;10478.63324783629;10654.520546575268;10679.359238445719;11127.276727012719;10132.378819388863;11095.778084438105;11784.4696988634;11826.408679565815;11921.582744603897 16:33:21 INFO - PROCESS | 15530 | __end_tp_report 16:33:21 INFO - PROCESS | 15530 | __start_cc_report 16:33:21 INFO - PROCESS | 15530 | _x_x_mozilla_cycle_collect,337 16:33:21 INFO - PROCESS | 15530 | __end_cc_report 16:33:21 INFO - PROCESS | 15530 | __startTimestamp1471822401389__endTimestamp 16:33:21 INFO - PROCESS | 15530 | 16:33:21 INFO - PROCESS | 15530 | ------- Summary: start ------- 16:33:21 INFO - PROCESS | 15530 | Number of tests: 6 16:33:21 INFO - PROCESS | 15530 | 16:33:21 INFO - PROCESS | 15530 | [#0] dojo.html Cycles:165 Average:5474.72 Median:5682.80 stddev:641.95 (11.3%) stddev-sans-first:614.77 16:33:21 INFO - PROCESS | 15530 | Values: 3036.6 3070.9 3091.0 3098.6 3100.9 5376.4 5486.9 5550.6 5571.3 5581.3 5381.5 5426.3 5432.4 5487.2 5493.8 4773.7 4989.9 5016.9 5074.9 5085.1 5015.7 5027.2 5034.0 5082.8 5097.6 4822.9 4850.8 4900.0 4927.7 5026.3 4988.6 4999.7 5013.4 5014.5 5016.9 4942.6 4981.7 5004.2 5008.5 5014.1 5368.3 5377.5 5414.0 5469.9 5492.8 5888.8 5897.7 5900.3 5902.5 5906.3 5797.0 5944.2 5946.4 5948.8 5960.0 5474.9 5490.8 5501.5 5573.5 5574.7 6112.9 6116.2 6120.1 6129.0 6133.2 5606.8 5851.2 5873.6 5876.3 5878.4 5743.7 5798.5 5809.2 5852.0 5854.1 5756.0 5839.4 5891.3 5933.7 5939.1 5920.5 5933.3 5935.3 5955.2 5958.2 4444.2 4476.7 4493.6 4509.5 4556.7 4011.3 4023.6 4038.4 4039.2 4041.4 5528.6 5555.1 5576.2 5578.8 5581.1 5840.5 5853.6 5858.3 5903.9 5956.4 5610.6 5671.7 5682.8 5685.9 5694.9 5150.9 5162.1 5175.3 5180.3 5183.0 5929.6 6034.7 6088.7 6104.9 6151.0 5952.0 5974.3 5978.1 5980.0 5983.8 6133.8 6153.0 6166.6 6180.8 6184.4 5507.1 5740.9 5790.9 5808.7 5888.4 5952.3 5969.3 5988.9 5999.0 5999.2 5821.9 5828.8 5832.0 5833.6 5835.9 5591.4 5659.9 5682.3 5691.5 5775.6 5677.5 5691.7 5692.4 5695.7 5698.8 5756.2 5780.2 5781.4 5824.6 5829.2 5508.4 5600.9 5623.9 5635.4 5731.9 16:33:21 INFO - PROCESS | 15530 | 16:33:21 INFO - PROCESS | 15530 | [#1] ext.html Cycles:180 Average:60591.07 Median:41104.78 stddev:130633.73 (317.8%) stddev-sans-first:130922.43 16:33:21 INFO - PROCESS | 15530 | Values: 555.2 560.7 560.9 561.4 614.4 39284.2 43491.0 43540.8 43668.6 43813.0 42873.6 43484.1 43530.6 43530.8 43984.0 8892.9 8908.8 9050.6 9058.9 9071.0 8933.2 8977.4 8985.7 9007.1 9024.1 9011.5 9041.1 9042.0 9053.7 9088.9 8929.8 8977.9 8982.6 8990.1 9016.7 8863.0 8873.8 8948.3 8953.5 8959.6 40274.4 41066.4 41143.2 41233.6 41329.6 3476.7 3725.1 3861.5 3961.8 4216.0 31600.0 31969.8 32293.5 32328.8 34146.5 4091.8 4131.6 4204.2 4243.8 4313.3 262177.0 262220.0 262924.7 263327.0 264202.0 35312.8 57504.1 57701.0 57755.0 57837.0 36406.8 38195.0 38374.8 38377.4 38387.6 14125.1 14321.1 14335.0 14363.9 14393.8 11800.9 11836.9 11870.6 11907.7 11986.6 8532.3 8639.2 8689.5 8737.3 8763.4 3330.2 3389.1 3392.8 3405.6 3411.2 931.4 969.9 1074.5 1113.8 1151.8 29020.6 29103.6 29126.4 29497.6 29524.9 1076.7 1081.5 1085.2 1158.1 1166.3 14366.0 15046.2 15135.7 15176.7 15396.2 625239.0 629639.0 630813.0 632252.0 635989.0 58794.7 59167.7 59351.0 59458.4 59793.7 1286.9 1313.5 1358.5 1367.5 1370.6 26799.9 28478.6 28716.6 28922.2 29496.3 51794.5 51811.2 51818.5 51971.2 52211.0 493740.0 493764.0 494827.0 495944.0 502293.0 28089.8 28898.3 29040.1 29209.9 29222.7 48260.8 48428.0 48741.8 49477.3 49565.3 40662.8 40751.8 40855.8 41509.8 42637.8 40232.2 41191.6 41341.8 42101.4 42664.8 35527.0 36097.8 36308.0 37431.0 39144.4 33216.3 37047.3 38030.0 38200.4 38968.0 25378.9 26016.5 26889.6 27364.3 27663.3 16:33:21 INFO - PROCESS | 15530 | 16:33:21 INFO - PROCESS | 15530 | [#2] jquery.html Cycles:180 Average:30687.78 Median:41454.50 stddev:82205.19 (198.3%) stddev-sans-first:82404.27 16:33:21 INFO - PROCESS | 15530 | Values: 368.8 384.1 385.3 394.9 407.7 17903.8 19854.0 20156.6 20159.7 20177.6 17541.6 17828.2 17987.9 20539.2 21066.3 6024.9 6355.9 6618.1 6638.1 6643.5 6496.4 6543.4 6555.4 6575.4 6579.0 6377.6 6546.5 6563.7 6584.6 6603.5 6517.9 6600.4 6601.8 7302.2 7672.7 7233.4 7521.4 7524.0 7540.4 7555.5 26055.5 26060.2 27010.6 27020.7 27255.7 2615.7 2644.8 2710.7 2720.5 2730.5 15640.8 15975.9 16222.8 16715.8 17166.3 2087.9 2117.3 2121.8 2174.8 2201.3 90193.0 90551.5 93063.5 93515.0 93864.1 17386.4 17444.9 17579.3 18161.7 19471.3 30988.5 31025.7 31085.2 31207.0 31486.8 9126.9 9374.6 9551.4 9565.9 9890.6 7728.3 7940.7 8123.4 8177.8 8216.8 8340.4 8672.2 8891.7 8971.6 9052.2 3386.6 3444.4 3535.9 3653.6 3667.7 882.4 903.2 977.6 984.4 1043.9 17328.7 17945.9 18063.7 18172.3 18650.8 966.5 985.2 991.4 996.0 1027.3 9497.1 10180.4 10219.5 10343.4 10382.7 491500.0 492997.0 494440.0 501969.0 509036.0 93902.0 94665.0 94994.0 95809.5 96180.5 998.2 1039.8 1043.6 1057.8 1065.1 15386.5 15413.8 15461.8 15953.4 16415.4 40344.4 40425.4 40883.8 41240.0 41669.0 57990.4 59231.7 59424.4 60448.4 62773.4 7257.0 7688.5 8189.8 8276.4 8596.5 12647.2 12912.9 13301.5 13409.4 13418.9 7843.7 8089.1 8284.5 11210.7 11324.0 7765.5 8018.4 8276.9 8437.6 8466.2 8316.7 8470.2 8485.0 8519.3 8640.2 12499.9 12597.0 12724.1 12844.5 13189.1 11503.7 11565.0 11927.8 12039.6 12242.7 16:33:21 INFO - PROCESS | 15530 | 16:33:21 INFO - PROCESS | 15530 | [#3] mootools.html Cycles:180 Average:6137.64 Median:4996.99 stddev:3528.98 (70.6%) stddev-sans-first:3521.26 16:33:21 INFO - PROCESS | 15530 | Values: 1445.0 1497.3 1625.3 1714.7 1755.5 7928.6 8712.1 8858.6 9546.1 9605.9 8915.3 9269.7 9331.1 9343.4 9376.9 2481.4 2497.8 2508.1 2513.3 2537.9 2344.8 2436.9 2440.3 2441.9 2445.5 2447.0 2447.3 2448.4 2455.5 2463.8 2381.5 2401.0 2419.4 2429.7 2450.3 2432.5 2432.6 2433.6 2439.9 2456.0 9378.1 9424.8 9469.6 9574.6 9578.9 5517.7 5650.4 5666.3 5698.5 5716.3 3542.4 3716.3 3795.3 3798.4 3822.9 1067.3 1132.3 1144.5 1169.7 1197.8 13287.9 13311.5 13317.1 13372.7 13429.9 4811.3 4982.7 5011.3 5092.4 5166.7 11132.9 11245.8 11254.9 11256.9 11268.2 5552.5 5611.3 5612.1 5616.5 5622.0 4403.5 4809.3 4955.9 5026.8 5083.9 4064.2 4240.7 4457.1 4462.6 4469.9 1353.3 1358.2 1377.1 1380.7 1393.2 923.6 935.3 940.2 943.1 951.8 6035.5 6091.3 6136.3 6368.1 6404.7 919.8 935.2 984.5 1004.6 1039.4 3997.7 4001.7 4093.7 4136.6 4149.2 11465.2 11860.6 11966.5 11986.9 12019.9 11070.7 11508.4 11542.5 11834.8 11869.5 8212.8 8340.8 8396.7 8444.7 8456.2 6060.2 6318.9 6394.2 6496.4 6536.1 9972.6 10598.3 10797.9 10816.4 10888.1 10472.0 10814.8 10819.6 10932.7 10965.1 7522.8 8140.1 8243.6 8356.8 8541.8 9270.9 9318.0 9349.1 9358.1 9367.8 7842.7 7962.2 8001.1 8097.6 8146.6 7656.3 7739.4 7741.8 7757.8 7935.8 7116.4 7197.9 7253.8 7265.6 7282.1 5303.5 5430.9 5467.3 5480.6 5541.1 5383.9 5384.6 5442.4 5475.9 5579.4 16:33:21 INFO - PROCESS | 15530 | 16:33:21 INFO - PROCESS | 15530 | [#4] prototype.html Cycles:180 Average:4706.84 Median:5263.09 stddev:1387.18 (26.4%) stddev-sans-first:1351.39 16:33:21 INFO - PROCESS | 15530 | Values: 317.9 324.8 329.4 329.7 332.6 5378.2 5407.7 5576.9 5634.0 5671.7 5438.2 5452.2 5472.4 5502.6 5513.3 4298.5 4309.7 4312.7 4319.5 4324.8 4168.6 4254.9 4291.2 4321.8 4331.0 4272.1 4278.0 4295.5 4298.7 4305.0 4303.4 4307.4 4310.1 4310.2 4319.4 3687.3 3760.9 3812.4 3816.7 3843.7 5346.6 5354.8 5407.6 5415.9 5427.2 4869.7 4902.6 4917.5 4931.2 4941.0 5491.8 5655.6 5728.6 5747.7 5781.4 4073.5 4083.3 4086.8 4099.8 4114.9 6040.1 6080.2 6081.0 6089.8 6137.8 3892.7 4087.5 4243.7 4266.1 4283.1 4168.5 4178.7 4180.4 4183.2 4183.6 4811.2 4850.9 4865.6 4868.9 4879.7 5621.4 5760.7 5767.9 5854.3 5888.1 1417.4 1444.6 1449.0 1450.5 1451.6 885.0 904.5 924.6 936.9 938.3 4871.2 4887.1 4897.0 4919.0 4980.5 5159.6 5188.6 5190.2 5192.5 5207.0 4710.3 4733.5 4900.8 4922.9 4945.6 2728.3 2749.5 2756.4 2767.4 2787.6 5269.7 5330.9 5337.9 5350.9 5402.6 5021.8 5305.7 5341.5 5348.8 5349.8 5372.3 5372.7 5377.0 5378.5 5389.6 5181.4 5200.6 5207.7 5256.5 5287.8 5213.3 5469.7 5863.8 5902.0 5917.6 6187.4 6193.0 6223.9 6245.7 6247.3 3896.9 4138.5 4146.8 4153.2 4163.7 5725.9 5888.4 5903.5 5904.3 5949.4 5781.7 5795.0 5795.2 5798.3 5804.2 5769.7 5769.9 5788.5 5793.9 5859.5 5580.4 5631.9 5723.8 5744.0 5768.8 5830.3 5845.6 5866.3 5898.2 5924.5 5646.4 5665.9 5714.6 5766.8 5774.5 16:33:21 INFO - PROCESS | 15530 | 16:33:21 INFO - PROCESS | 15530 | [#5] yui.html Cycles:180 Average:20731.08 Median:4385.93 stddev:30401.89 (693.2%) stddev-sans-first:30450.11 16:33:21 INFO - PROCESS | 15530 | Values: 738.6 783.2 784.5 822.1 851.7 15187.4 16268.1 16426.0 16463.1 16513.1 14744.6 14850.3 14884.4 14905.0 14923.3 796.5 805.8 808.9 812.9 843.3 832.2 835.8 836.0 836.4 837.2 865.8 868.4 871.9 872.5 873.6 867.1 871.5 873.6 875.4 875.5 626.9 629.0 631.5 632.8 634.9 14410.9 14411.6 14415.0 14456.9 14497.2 14112.6 14224.6 14233.4 14431.9 14464.4 12450.3 12531.6 12582.0 12628.2 13304.1 3550.0 3682.6 3717.0 3742.1 3742.7 90247.5 91268.5 93399.5 93677.5 94826.0 10895.8 11169.3 11208.0 11323.3 11499.7 21419.4 21538.1 21657.2 21704.2 21750.8 7821.7 7894.2 8214.0 8359.9 8418.3 4563.2 4664.7 4666.5 4716.4 4719.7 3428.9 3519.8 3524.0 3528.1 3553.9 559.3 594.2 605.2 612.6 623.5 573.3 622.9 655.8 659.9 692.5 8766.2 9001.1 9126.3 9373.9 9573.4 507.8 593.2 622.6 654.9 672.8 4020.8 4044.1 4110.5 4194.8 4208.6 72419.6 119440.4 121423.0 129143.0 134060.0 31043.2 50519.5 62969.7 65515.3 103742.5 93202.0 93588.5 94491.1 95017.5 96157.5 7963.3 8060.4 8109.7 8225.9 8272.4 54477.7 54534.0 54599.2 56791.0 59104.7 73959.3 75198.0 83900.6 83940.6 84544.6 12071.3 12359.4 12368.7 12774.6 12943.5 14559.5 14955.6 14971.0 15349.2 15495.6 12335.4 13116.9 14427.4 14708.6 14865.6 12697.6 13266.3 13268.6 14596.9 14674.8 14193.0 14236.6 14262.4 14527.9 14544.4 10210.9 10478.6 10654.5 10679.4 11127.3 10132.4 11095.8 11784.5 11826.4 11921.6 16:33:21 INFO - PROCESS | 15530 | -------- Summary: end -------- 16:33:21 INFO - PROCESS | 15530 | 16:33:22 INFO - TEST-INFO | 15530: exit 0 16:33:22 INFO - TEST-OK | dromaeo_css | took 1113473ms 16:33:22 INFO - TEST-START | kraken 16:33:22 INFO - operating with platform_type : linux_ 16:33:22 INFO - Initialising browser for kraken test... 16:33:22 INFO - TEST-INFO | started process 15895 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNjlqS2/profile http://localhost:37406/getInfo.html) 16:33:27 INFO - PROCESS | 15895 | __metrics Screen width/height:1600/1200 16:33:27 INFO - PROCESS | 15895 | colorDepth:24 16:33:27 INFO - PROCESS | 15895 | Browser inner width/height: 1024/697 16:33:27 INFO - PROCESS | 15895 | __metrics 16:33:27 ERROR - PROCESS | 15895 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2993: TypeError: this.tabs is undefined 16:33:28 INFO - TEST-INFO | 15895: exit 0 16:33:28 INFO - Browser initialized. 16:33:28 INFO - Running cycle 1/1 for kraken test... 16:33:28 INFO - TEST-INFO | started process 16013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNjlqS2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:33:40 INFO - PROCESS | 16013 | RSS: Main: 186236928 16:33:40 INFO - PROCESS | 16013 | 16:33:43 INFO - PROCESS | 16013 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37406/tests/kraken/driver.html?testName=audio-beat-detection) 16:33:44 INFO - PROCESS | 16013 | RSS: Main: 199426048 16:33:44 INFO - PROCESS | 16013 | 16:33:47 INFO - PROCESS | 16013 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37406/tests/kraken/driver.html?testName=audio-dft) 16:33:47 INFO - PROCESS | 16013 | RSS: Main: 199086080 16:33:47 INFO - PROCESS | 16013 | 16:33:50 INFO - PROCESS | 16013 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37406/tests/kraken/driver.html?testName=audio-fft) 16:33:51 INFO - PROCESS | 16013 | RSS: Main: 194326528 16:33:51 INFO - PROCESS | 16013 | 16:33:53 INFO - PROCESS | 16013 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37406/tests/kraken/driver.html?testName=audio-oscillator) 16:33:54 INFO - PROCESS | 16013 | RSS: Main: 195284992 16:33:54 INFO - PROCESS | 16013 | 16:33:56 INFO - PROCESS | 16013 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37406/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:33:57 INFO - PROCESS | 16013 | RSS: Main: 196071424 16:33:57 INFO - PROCESS | 16013 | 16:34:00 INFO - PROCESS | 16013 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37406/tests/kraken/driver.html?testName=imaging-darkroom) 16:34:00 INFO - PROCESS | 16013 | RSS: Main: 195956736 16:34:00 INFO - PROCESS | 16013 | 16:34:04 INFO - PROCESS | 16013 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37406/tests/kraken/driver.html?testName=imaging-desaturate) 16:34:04 INFO - PROCESS | 16013 | RSS: Main: 193318912 16:34:04 INFO - PROCESS | 16013 | 16:34:07 INFO - PROCESS | 16013 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37406/tests/kraken/driver.html?testName=json-parse-financial) 16:34:08 INFO - PROCESS | 16013 | RSS: Main: 194621440 16:34:08 INFO - PROCESS | 16013 | 16:34:10 INFO - PROCESS | 16013 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37406/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:34:10 INFO - PROCESS | 16013 | RSS: Main: 194748416 16:34:10 INFO - PROCESS | 16013 | 16:34:12 INFO - PROCESS | 16013 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37406/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:34:13 INFO - PROCESS | 16013 | RSS: Main: 194867200 16:34:13 INFO - PROCESS | 16013 | 16:34:15 INFO - PROCESS | 16013 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37406/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:34:15 INFO - PROCESS | 16013 | RSS: Main: 196009984 16:34:15 INFO - PROCESS | 16013 | 16:34:18 INFO - PROCESS | 16013 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37406/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:34:19 INFO - PROCESS | 16013 | RSS: Main: 196554752 16:34:19 INFO - PROCESS | 16013 | 16:34:22 INFO - PROCESS | 16013 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37406/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:34:22 INFO - PROCESS | 16013 | RSS: Main: 196399104 16:34:22 INFO - PROCESS | 16013 | 16:34:24 INFO - PROCESS | 16013 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37406/tests/kraken/driver.html?testName=ai-astar) 16:34:24 INFO - PROCESS | 16013 | RSS: Main: 198193152 16:34:24 INFO - PROCESS | 16013 | 16:34:24 INFO - PROCESS | 16013 | __start_tp_report 16:34:24 INFO - PROCESS | 16013 | _x_x_mozilla_page_load 16:34:24 INFO - PROCESS | 16013 | _x_x_mozilla_page_load_details 16:34:24 INFO - PROCESS | 16013 | |i|pagename|runs| 16:34:24 INFO - PROCESS | 16013 | |0;ai-astar;103;112;108;112;113;114;119;113;113;113 16:34:24 INFO - PROCESS | 16013 | |1;audio-beat-detection;151;123;155;195;129;152;157;123;185;127 16:34:24 INFO - PROCESS | 16013 | |2;audio-dft;165;170;166;192;165;163;164;165;165;165 16:34:24 INFO - PROCESS | 16013 | |3;audio-fft;77;77;77;181;79;78;76;79;195;78 16:34:24 INFO - PROCESS | 16013 | |4;audio-oscillator;100;87;157;86;86;91;137;86;86;145 16:34:24 INFO - PROCESS | 16013 | |5;imaging-gaussian-blur;118;119;118;117;118;117;119;119;119;118 16:34:24 INFO - PROCESS | 16013 | |6;imaging-darkroom;149;148;150;148;149;147;147;150;155;147 16:34:24 INFO - PROCESS | 16013 | |7;imaging-desaturate;96;97;96;96;95;95;96;96;96;96 16:34:24 INFO - PROCESS | 16013 | |8;json-parse-financial;54;52;54;53;54;57;57;59;55;55 16:34:24 INFO - PROCESS | 16013 | |9;json-stringify-tinderbox;63;65;62;62;62;62;63;63;62;64 16:34:24 INFO - PROCESS | 16013 | |10;stanford-crypto-aes;81;90;83;85;80;81;82;89;79;85 16:34:24 INFO - PROCESS | 16013 | |11;stanford-crypto-ccm;130;129;137;133;127;136;155;130;194;131 16:34:24 INFO - PROCESS | 16013 | |12;stanford-crypto-pbkdf2;167;175;174;170;170;179;167;169;165;187 16:34:24 INFO - PROCESS | 16013 | |13;stanford-crypto-sha256-iterative;67;71;75;68;70;70;66;67;66;66 16:34:24 INFO - PROCESS | 16013 | __end_tp_report 16:34:24 INFO - PROCESS | 16013 | __start_cc_report 16:34:24 INFO - PROCESS | 16013 | _x_x_mozilla_cycle_collect,859 16:34:24 INFO - PROCESS | 16013 | __end_cc_report 16:34:24 INFO - PROCESS | 16013 | __startTimestamp1471822464784__endTimestamp 16:34:24 INFO - PROCESS | 16013 | 16:34:24 INFO - PROCESS | 16013 | ------- Summary: start ------- 16:34:24 INFO - PROCESS | 16013 | Number of tests: 14 16:34:24 INFO - PROCESS | 16013 | 16:34:24 INFO - PROCESS | 16013 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:4.14 (3.7%) stddev-sans-first:2.83 16:34:24 INFO - PROCESS | 16013 | Values: 103.0 112.0 108.0 112.0 113.0 114.0 119.0 113.0 113.0 113.0 16:34:24 INFO - PROCESS | 16013 | 16:34:24 INFO - PROCESS | 16013 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:153.50 stddev:25.29 (16.5%) stddev-sans-first:26.82 16:34:24 INFO - PROCESS | 16013 | Values: 151.0 123.0 155.0 195.0 129.0 152.0 157.0 123.0 185.0 127.0 16:34:24 INFO - PROCESS | 16013 | 16:34:24 INFO - PROCESS | 16013 | [#2] audio-dft Cycles:10 Average:168.00 Median:165.00 stddev:8.63 (5.2%) stddev-sans-first:9.08 16:34:24 INFO - PROCESS | 16013 | Values: 165.0 170.0 166.0 192.0 165.0 163.0 164.0 165.0 165.0 165.0 16:34:24 INFO - PROCESS | 16013 | 16:34:24 INFO - PROCESS | 16013 | [#3] audio-fft Cycles:10 Average:99.70 Median:77.50 stddev:46.66 (60.2%) stddev-sans-first:48.77 16:34:24 INFO - PROCESS | 16013 | Values: 77.0 77.0 77.0 181.0 79.0 78.0 76.0 79.0 195.0 78.0 16:34:24 INFO - PROCESS | 16013 | 16:34:24 INFO - PROCESS | 16013 | [#4] audio-oscillator Cycles:10 Average:106.10 Median:86.00 stddev:28.49 (33.1%) stddev-sans-first:30.13 16:34:24 INFO - PROCESS | 16013 | Values: 100.0 87.0 157.0 86.0 86.0 91.0 137.0 86.0 86.0 145.0 16:34:24 INFO - PROCESS | 16013 | 16:34:24 INFO - PROCESS | 16013 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.50 stddev:0.79 (0.7%) stddev-sans-first:0.83 16:34:24 INFO - PROCESS | 16013 | Values: 118.0 119.0 118.0 117.0 118.0 117.0 119.0 119.0 119.0 118.0 16:34:24 INFO - PROCESS | 16013 | 16:34:24 INFO - PROCESS | 16013 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:2.40 (1.6%) stddev-sans-first:2.55 16:34:24 INFO - PROCESS | 16013 | Values: 149.0 148.0 150.0 148.0 149.0 147.0 147.0 150.0 155.0 147.0 16:34:24 INFO - PROCESS | 16013 | 16:34:24 INFO - PROCESS | 16013 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 16:34:24 INFO - PROCESS | 16013 | Values: 96.0 97.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 16:34:24 INFO - PROCESS | 16013 | 16:34:24 INFO - PROCESS | 16013 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:2.11 (3.8%) stddev-sans-first:2.20 16:34:24 INFO - PROCESS | 16013 | Values: 54.0 52.0 54.0 53.0 54.0 57.0 57.0 59.0 55.0 55.0 16:34:24 INFO - PROCESS | 16013 | 16:34:24 INFO - PROCESS | 16013 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 16:34:24 INFO - PROCESS | 16013 | Values: 63.0 65.0 62.0 62.0 62.0 62.0 63.0 63.0 62.0 64.0 16:34:24 INFO - PROCESS | 16013 | 16:34:24 INFO - PROCESS | 16013 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:84.00 stddev:3.72 (4.4%) stddev-sans-first:3.83 16:34:24 INFO - PROCESS | 16013 | Values: 81.0 90.0 83.0 85.0 80.0 81.0 82.0 89.0 79.0 85.0 16:34:24 INFO - PROCESS | 16013 | 16:34:24 INFO - PROCESS | 16013 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:134.50 stddev:20.51 (15.2%) stddev-sans-first:21.42 16:34:24 INFO - PROCESS | 16013 | Values: 130.0 129.0 137.0 133.0 127.0 136.0 155.0 130.0 194.0 131.0 16:34:24 INFO - PROCESS | 16013 | 16:34:24 INFO - PROCESS | 16013 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:172.00 stddev:6.68 (3.9%) stddev-sans-first:6.81 16:34:24 INFO - PROCESS | 16013 | Values: 167.0 175.0 174.0 170.0 170.0 179.0 167.0 169.0 165.0 187.0 16:34:24 INFO - PROCESS | 16013 | 16:34:24 INFO - PROCESS | 16013 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:2.91 (4.2%) stddev-sans-first:3.03 16:34:24 INFO - PROCESS | 16013 | Values: 67.0 71.0 75.0 68.0 70.0 70.0 66.0 67.0 66.0 66.0 16:34:24 INFO - PROCESS | 16013 | -------- Summary: end -------- 16:34:24 INFO - PROCESS | 16013 | 16:34:25 INFO - TEST-INFO | 16013: exit 0 16:34:25 INFO - TEST-OK | kraken | took 63563ms 16:34:25 INFO - SUITE-END | took 1177s 16:34:25 INFO - Completed test suite (00:19:37) 16:34:25 INFO - javascript benchmark 16:34:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7374.484809273096, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3036.635603727553, 3070.9405255186953, 3090.995426486391, 3098.5816914716506, 3100.8914687985925, 5376.381716102649, 5486.862828429286, 5550.583706222029, 5571.303587051619, 5581.274434323537, 5381.515663590276, 5426.321709786277, 5432.402435732066, 5487.2317875497465, 5493.7802487900435, 4773.665843390964, 4989.850304490871, 5016.874578135539, 5074.923876141861, 5085.110105731501, 5015.724135172564, 5027.170516864713, 5033.974830125844, 5082.771275292602, 5097.617678674096, 4822.927656085161, 4850.830220942268, 4900.0199960007785, 4927.6550641455115, 5026.271190677331, 4988.600911927074, 4999.650024498286, 5013.398392192924, 5014.498550144993, 5016.8996620067755, 4942.629302802268, 4981.676191047571, 5004.199328107522, 5008.474110218411, 5014.147594908838, 5368.275282836845, 5377.46225377463, 5413.972930135364, 5469.917951230735, 5492.835214943558, 5888.823335299905, 5897.705114744289, 5900.262467191601, 5902.498287645555, 5906.26171728534, 5797.0, 5944.197533333031, 5946.375630558772, 5948.7620495180145, 5960.0, 5474.863128421782, 5490.752916118744, 5501.5323697485765, 5573.526250268773, 5574.693391863487, 6112.877742445126, 6116.2048933639235, 6120.112583675342, 6128.969355153285, 6133.233345831771, 5606.831795046155, 5851.239338886003, 5873.647581145145, 5876.265466816648, 5878.353381128158, 5743.684097374685, 5798.536117110621, 5809.186713860063, 5852.0, 5854.063349864001, 5756.0, 5839.386864379264, 5891.3224979127945, 5933.732982015819, 5939.07944268639, 5920.526357891445, 5933.3473317934995, 5935.287765468085, 5955.225820643289, 5958.225430693982, 4444.177827101997, 4476.686631935799, 4493.640508759357, 4509.481409637868, 4556.681032327771, 4011.3180759270995, 4023.637872591481, 4038.374052021941, 4039.171969746195, 4041.3937909313836, 5528.640638358494, 5555.111182210827, 5576.219329293902, 5578.804741834017, 5581.107022876401, 5840.474357307863, 5853.590248682552, 5858.297004359419, 5903.852403689943, 5956.374580669054, 5610.551155907518, 5671.6597004179885, 5682.801101961411, 5685.914711279334, 5694.9430505695245, 5150.871228219325, 5162.09663308927, 5175.327207463081, 5180.300659411007, 5183.0, 5929.555283353766, 6034.668093254913, 6088.695565221721, 6104.908426373519, 6150.954337762681, 5951.970240148771, 5974.342822289458, 5978.133170690313, 5980.013297805987, 5983.790567330297, 6133.8466538335115, 6152.969235153795, 6166.568340216142, 6180.783672571439, 6184.412480814315, 5507.146392309039, 5740.856478587902, 5790.9420905792085, 5808.680522571299, 5888.440598143169, 5952.315483719428, 5969.343372229138, 5988.880222395441, 5999.040153575407, 5999.160117583455, 5821.854453638693, 5828.795992140254, 5832.0, 5833.562482813721, 5835.912461312999, 5591.412901645269, 5659.943400565941, 5682.318121825408, 5691.487766100905, 5775.566832487496, 5677.460641239076, 5691.686957217393, 5692.430756924275, 5695.686737229492, 5698.800541981011, 5756.165356023437, 5780.21967034445, 5781.364049954417, 5824.592278540462, 5829.242198514166, 5508.394076651485, 5600.887982240414, 5623.943760562342, 5635.380108188178, 5731.942680573141], "value": 5429.427019859182, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.1783360626274, 560.7280468972548, 560.9146301905813, 561.4469747298913, 614.4439282449384, 39284.2143157137, 43491.0, 43540.78229608852, 43668.563314366846, 43813.0, 42873.57126428735, 43484.13031739363, 43530.564694353045, 43530.7823460883, 43984.0, 8892.8666070009, 8908.777280567972, 9050.592723327467, 9058.909410905873, 9070.954645226764, 8933.24067454264, 8977.416467929595, 8985.685501007467, 9007.144321289466, 9024.052474490183, 9011.504367259799, 9041.050689677555, 9042.0, 9053.683121090764, 9088.909110908906, 8929.821403571892, 8977.86533201996, 8982.640694372218, 8990.05604411534, 9016.729498115066, 8863.0, 8873.778155546099, 8948.284137269004, 8953.462792232487, 8959.552022398853, 40274.39588406176, 41066.38400423996, 41143.1771364574, 41233.58766412357, 41329.586704132875, 3476.652334766503, 3725.1059745660846, 3861.4787003754413, 3961.7821019843896, 4215.957840421587, 31600.0, 31969.84015079933, 32293.51559726606, 32328.838355808304, 34146.48780268298, 4091.8363265469347, 4131.566185550534, 4204.1801848639225, 4243.830246790125, 4313.309870420749, 262177.0, 262220.0, 262924.6853765738, 263327.0, 264202.0, 35312.82343588266, 57504.137437938465, 57700.99999999916, 57755.0, 57837.0, 36406.81796591053, 38195.0, 38374.80812595975, 38377.42433863494, 38387.61612383896, 14125.081869678643, 14321.14073155614, 14335.0, 14363.928180359031, 14393.78409323861, 11800.940995294968, 11836.88163118375, 11870.584529541424, 11907.702307442383, 11986.64040078799, 8532.317414606816, 8639.222469977733, 8689.478631282143, 8737.257333126629, 8763.386562940661, 3330.200751819594, 3389.1357703785375, 3392.830358482066, 3405.625381208065, 3411.1642647551507, 931.4085555672197, 969.8981606931312, 1074.5325783284297, 1113.8106521891298, 1151.7926773180907, 29020.564691529646, 29103.56344654832, 29126.41747165087, 29497.557536636967, 29524.933254672396, 1076.6931424544125, 1081.4700796609761, 1085.2132204152085, 1158.073541167063, 1166.3468457663735, 14366.0, 15046.172460514777, 15135.697286054217, 15176.696466070616, 15396.23018849053, 625239.0, 629639.0, 630813.0, 632252.0, 635989.0, 58794.7060264696, 59167.70416147892, 59351.0, 59458.40541594615, 59793.701031494566, 1286.9420876060599, 1313.507434711983, 1358.456617353047, 1367.500862185315, 1370.6436326554967, 26799.86600066987, 28478.57932075714, 28716.569251461664, 28922.214408114145, 29496.262593435335, 51794.48205517897, 51811.15038672758, 51818.48181518137, 51971.2204316928, 52211.0, 493740.0, 493764.0, 494827.0, 495944.0, 502293.0, 28089.77575974831, 28898.27754306159, 29040.12879613615, 29209.85395073011, 29222.707772922, 48260.75869620629, 48428.03143937031, 48741.75629121832, 49477.25784113169, 49565.25652115149, 40662.79668601638, 40751.79624101861, 40855.795721021204, 41509.79245103755, 42637.786811065744, 40232.195356093296, 41191.588084118775, 41341.793291033355, 42101.36847947222, 42664.78667606642, 35527.0, 36097.81951090228, 36308.0, 37431.0, 39144.41283380695, 33216.33567328592, 37047.25905481821, 38030.049248769, 38200.42699359456, 38968.0, 25378.873105634353, 26016.479670406865, 26889.596656050566, 27364.315892102855, 27663.30841728973], "value": 18684.159821480203, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.78241837315994, 384.1491097219659, 385.31606398642407, 394.92693851637466, 407.74515927545286, 17903.820961790378, 19854.0, 20156.59686806263, 20159.697604535944, 20177.596448071028, 17541.64916701665, 17828.1977311021, 17987.910060449678, 20539.178432862704, 21066.262680806176, 6024.879502409949, 6355.936440635593, 6618.073469714244, 6638.103855979453, 6643.501737369693, 6496.382843629847, 6543.443807276387, 6555.3772391622715, 6575.441087507567, 6579.04603832444, 6377.585456945307, 6546.4762818974605, 6563.737450501974, 6584.572002819826, 6603.471722262231, 6517.869642607145, 6600.4389626881775, 6601.834954126161, 7302.1967583565765, 7672.73145439907, 7233.421326293884, 7521.4358923080445, 7524.0, 7540.359069479101, 7555.5088919220625, 26055.478890422273, 26060.218193454228, 27010.5948410774, 27020.72979270202, 27255.727442725518, 2615.712271650136, 2644.8413095214155, 2710.6611673540806, 2720.455908818244, 2730.4675588260297, 15640.765388519181, 15975.920120399323, 16222.83777162237, 16715.83284167155, 17166.313347466086, 2087.926922557703, 2117.2589593642256, 2121.819645330149, 2174.836887233448, 2201.2955854126685, 90193.0, 90551.54724226403, 93063.53468232615, 93515.0, 93864.06135938622, 17386.391476298522, 17444.91277543604, 17579.29682812673, 18161.7275740864, 19471.318503852297, 30988.53517197244, 31025.689743102732, 31085.22286942799, 31207.0, 31486.842565787483, 9126.908730912739, 9374.62501499946, 9551.379160354554, 9565.904340956502, 9890.60437582503, 7728.343090837229, 7940.682372705142, 8123.4313598047565, 8177.79555511117, 8216.83566328682, 8340.37447191463, 8672.184238934975, 8891.688790892287, 8971.551422428984, 9052.185303322733, 3386.6274709781906, 3444.4488881778793, 3535.911602209965, 3653.606887488646, 3667.7249206309634, 882.4131952251809, 903.1871315815819, 977.63827383867, 984.4437892590663, 1043.888259004158, 17328.747262855748, 17945.910270448563, 18063.72904406435, 18172.27310907575, 18650.813491865178, 966.4925913895261, 985.2413641496152, 991.4348821171862, 995.9651412200539, 1027.275770581738, 9497.097775711296, 10180.440075795754, 10219.489025548693, 10343.4311112888, 10382.688519344432, 491500.0, 492997.0, 494440.0, 501969.0, 509036.0, 93902.0, 94665.0, 94994.0, 95809.52095239479, 96180.51909740406, 998.1665309466531, 1039.812833689943, 1043.645160645369, 1057.846612241236, 1065.1319174872608, 15386.461473848361, 15413.76879346833, 15461.768073479132, 15953.441629542911, 16415.42546010884, 40344.3948340781, 40425.39361909515, 40883.79558102191, 41240.0, 41669.0, 57990.42009580019, 59231.703841480514, 59424.40575594362, 60448.39551604604, 62773.37226627858, 7257.0, 7688.538687678757, 8189.754307370788, 8276.379271554779, 8596.484210947363, 12647.241165530098, 12912.935435322763, 13301.467941282628, 13409.396577153857, 13418.93290533541, 7843.6862525498345, 8089.069756978023, 8284.50292982423, 11210.719732006764, 11324.0, 7765.456418050682, 8018.398620103632, 8276.917230827614, 8437.620307086074, 8466.195711407407, 8316.6673333066, 8470.15298470148, 8485.0, 8519.275861551838, 8640.179182977607, 12499.875001249871, 12597.0, 12724.109312348417, 12844.486220551073, 13189.142705724098, 11503.654890353302, 11565.0, 11927.821082683593, 12039.63881083569, 12242.693932651398], "value": 10221.331017399534, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1444.9855501444988, 1497.3411698852503, 1625.2523839034043, 1714.6913555559995, 1755.5084576318627, 7928.563928983904, 8712.128787121284, 8858.645654173826, 9546.140847323739, 9605.855912161314, 8915.286777057836, 9269.721908342744, 9331.066893310666, 9343.43939363637, 9376.906230937688, 2481.441675622984, 2497.825152239344, 2508.08454913956, 2513.28371414147, 2537.8857951392138, 2344.8358614896965, 2436.9390765230924, 2440.2801173653725, 2441.8534887906694, 2445.498672772086, 2446.9755302447015, 2447.3392184110367, 2448.3879030242438, 2455.5211733711935, 2463.8275320727557, 2381.452265978826, 2401.0275838285525, 2419.419339358559, 2429.7205821330595, 2450.2649205238536, 2432.5013372258645, 2432.647266146399, 2433.6349547568007, 2439.9390015249583, 2456.0175929628112, 9378.109079637492, 9424.811503769886, 9469.573869175903, 9574.617015319449, 9578.904210957871, 5517.724113794295, 5650.378458369576, 5666.320041595035, 5698.458646428583, 5716.342620598602, 3542.433210686278, 3716.3056783831776, 3795.278897009587, 3798.3542797724454, 3822.9044273893096, 1067.3062509368895, 1132.3375825142302, 1144.525022115821, 1169.7485040716288, 1197.8382918306004, 13287.870531004875, 13311.534096306583, 13317.134386264861, 13372.665683357896, 13429.865701343057, 4811.254255590389, 4982.676126051795, 5011.298418221452, 5092.38891333035, 5166.689998600096, 11132.888671113185, 11245.775084498264, 11254.943725281484, 11256.887431125584, 11268.211225214156, 5552.500274975191, 5611.298587676541, 5612.074007788669, 5616.494515493543, 5622.0, 4403.471583410012, 4809.302651115569, 4955.876103097379, 5026.824061157915, 5083.8983220335385, 4064.219041692595, 4240.724352917051, 4457.064016556495, 4462.576055274809, 4469.932951005738, 1353.2895230004326, 1358.1715153756202, 1377.0567161494207, 1380.7100508893045, 1393.171063217384, 923.6028507741736, 935.2517985611483, 940.191435365585, 943.056943056943, 951.8239125761756, 6035.456808887221, 6091.299500557404, 6136.325004249529, 6368.076628888785, 6404.679766011774, 919.7608621758258, 935.1910597333393, 984.532347135105, 1004.638330201127, 1039.417925961464, 3997.720159588859, 4001.7198796083994, 4093.7134400592267, 4136.614234231566, 4149.232392007489, 11465.197436179555, 11860.644180674593, 11966.521339146511, 11986.940065299617, 12019.87980120205, 11070.723231919266, 11508.36703981289, 11542.480588373543, 11834.76330473403, 11869.46587403569, 8212.794680133044, 8340.833183336421, 8396.748097557083, 8444.704435344856, 8456.196661317164, 6060.181875446759, 6318.936810632019, 6394.200724909387, 6496.350364963466, 6536.0522724205675, 9972.60109595637, 10598.25812193139, 10797.946010269898, 10816.351018938889, 10888.128949684165, 10472.0, 10814.837777433502, 10819.621313253998, 10932.672019839418, 10965.067969222386, 7522.849543009, 8140.063892652421, 8243.629036693483, 8356.832863342821, 8541.786455338417, 9270.860937085814, 9318.0, 9349.111834375723, 9358.064193580587, 9367.829021372328, 7842.72550460754, 7962.163972782774, 8001.079875814356, 8097.635606397608, 8146.592670366576, 7656.272654097852, 7739.380849532136, 7741.806454838674, 7757.844843102994, 7935.841283174189, 7116.3951064158055, 7197.928020719935, 7253.782386528413, 7265.600391978492, 7282.053333066668, 5303.522682958553, 5430.891382172255, 5467.316585426822, 5480.6437581557075, 5541.058020136506, 5383.946160538345, 5384.6499977501335, 5442.401335853132, 5475.890482190413, 5579.358373787067], "value": 4887.60340131907, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.94753865612176, 324.81810186295667, 329.3643268491811, 329.6719763834985, 332.61250643000903, 5378.1663842104435, 5407.729613519318, 5576.9163462548095, 5633.971830140848, 5671.6671582178205, 5438.211459338394, 5452.228025891591, 5472.440354498968, 5502.642328248661, 5513.3108361454815, 4298.527162012192, 4309.655227581786, 4312.698111132207, 4319.503257125431, 4324.84863029794, 4168.5623009584015, 4254.9149017019645, 4291.1632231714675, 4321.82712691492, 4331.0, 4272.124214536013, 4278.0, 4295.453636690789, 4298.677599180059, 4304.956950430487, 4303.376010478494, 4307.440032795748, 4310.116426132635, 4310.224159651261, 4319.352097185416, 3687.2809802088605, 3760.9435858462143, 3812.4281357796276, 3816.694664426867, 3843.7117216208617, 5346.625736198468, 5354.839354819362, 5407.594025553384, 5415.9458405415835, 5427.2361482517945, 4869.686898723114, 4902.583280421169, 4917.459079501252, 4931.235658472907, 4941.036497882914, 5491.807786727485, 5655.604107712462, 5728.627639203439, 5747.6551406915305, 5781.421857814227, 4073.531543872463, 4083.3262511685534, 4086.8160932758096, 4099.754014759124, 4114.855980040684, 6040.067178502881, 6080.209572755513, 6081.0, 6089.786857459968, 6137.754489820401, 3892.6885849132, 4087.529934057562, 4243.6605071594195, 4266.08279219963, 4283.143371325685, 4168.458100446983, 4178.7283826551175, 4180.408146948911, 4183.205191013698, 4183.560726123713, 4811.206150985048, 4850.854474365775, 4865.5864251538305, 4868.9269660955115, 4879.658423910292, 5621.437856214346, 5760.711964401763, 5767.942320576741, 5854.2974843018255, 5888.087346461305, 1417.4259424932918, 1444.59551325629, 1448.992755036218, 1450.5213279617913, 1451.5935538049152, 884.9955750221208, 904.5160838951261, 924.6024209589806, 936.8969413364524, 938.2728385501155, 4871.171900776805, 4887.095887260868, 4897.0, 4918.95081049185, 4980.477049909779, 5159.613029022838, 5188.636795424284, 5190.247414125006, 5192.506711862367, 5206.973965130226, 4710.3405523226775, 4733.526647335308, 4900.789982561428, 4922.876928076755, 4945.554900059012, 2728.331558768075, 2749.5188342040065, 2756.415061339698, 2767.405007923306, 2787.6376071110626, 5269.71016594091, 5330.8933821324135, 5337.879045400509, 5350.892982140335, 5402.621816472809, 5021.774020169101, 5305.681659100466, 5341.545968592635, 5348.839534813962, 5349.812756553502, 5372.274742909657, 5372.677639341652, 5376.973115134399, 5378.489043540857, 5389.649672771179, 5181.3782346118705, 5200.59583912334, 5207.6875387476875, 5256.474352564713, 5287.762050707651, 5213.296205012275, 5469.671819690831, 5863.765449381977, 5901.986649078496, 5917.615355001911, 6187.412195841388, 6193.0, 6223.906641400473, 6245.68771561411, 6247.344028877084, 3896.941545876871, 4138.461999939988, 4146.79266036703, 4153.169366126847, 4163.708540402143, 5725.856853578527, 5888.381719919518, 5903.527717782653, 5904.261967254093, 5949.434803693643, 5781.653100813965, 5795.0, 5795.24661793981, 5798.289504596239, 5804.158397032322, 5769.663286369027, 5769.91345129815, 5788.450097240755, 5793.91309130355, 5859.531237501075, 5580.441955804549, 5631.943680563306, 5723.828285151452, 5743.971280143573, 5768.788554403623, 5830.300363956352, 5845.620034697731, 5866.266716660418, 5898.233229680114, 5924.52603791687, 5646.407127251744, 5665.943340566541, 5714.628489162654, 5766.769329226784, 5774.48029677331], "value": 4259.606647339278, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.6085374751382, 783.2441693765516, 784.4665627373388, 822.0751654388813, 851.659336265494, 15187.392504299829, 16268.105254211014, 16426.0, 16463.09452980084, 16513.091779952098, 14744.557663270092, 14850.33173507192, 14884.404623815062, 14905.0, 14923.253837308119, 796.4743269442184, 805.8025783683006, 808.8786681997689, 812.8780682897553, 843.3464065349373, 832.2177153475744, 835.8453686068067, 835.9540225287607, 836.3685417509772, 837.1795640272536, 865.8095219051798, 868.3747701654798, 871.8561437362828, 872.5462759365126, 873.5719497446237, 867.1371984875058, 871.5119533061475, 873.6243415331405, 875.4353442029919, 875.4747151708988, 626.8777588370269, 629.0469938043867, 631.5421319543341, 632.7690393006519, 634.9238091429058, 14410.927945360207, 14411.639709007253, 14415.0, 14456.855431445656, 14497.202653854034, 14112.576622701336, 14224.573262802132, 14233.430662773477, 14431.927840360837, 14464.421423143061, 12450.3152326622, 12531.561395351118, 12582.0, 12628.17916835412, 13304.06871518994, 3550.0, 3682.5949145593963, 3716.981415092934, 3742.101895545077, 3742.700583953277, 90247.54876225643, 91268.54365728129, 93399.53300233523, 93677.53161234218, 94826.0, 10895.782084358269, 11169.329840209452, 11208.0, 11323.263987840764, 11499.655010349703, 21419.357419277447, 21538.13847446116, 21657.241996530047, 21704.240351587618, 21750.782492175193, 7821.687132514636, 7894.171112033268, 8213.95893020531, 8359.874601880976, 8418.326533877274, 4563.224251877189, 4664.673472856935, 4666.533346665306, 4716.434027916604, 4719.716816990923, 3428.8628454861528, 3519.8416071276856, 3523.982380088083, 3528.100334414708, 3553.9466907996402, 559.3427722426133, 594.2007999241014, 605.1890466774455, 612.5895649914568, 623.5354660777749, 573.3062993777493, 622.8723111762077, 655.8324736745103, 659.8623545043289, 692.4944790303007, 8766.167214114648, 9001.054889236666, 9126.315526335551, 9373.859392109123, 9573.425594464215, 507.7994192294023, 593.1606776411415, 622.5610944284268, 654.9279579246279, 672.7712577723597, 4020.798960051986, 4044.0698639313123, 4110.547839737626, 4194.769287689206, 4208.642265407413, 72419.63790181016, 119440.40279798546, 121423.0, 129143.0, 134060.0, 31043.223919402197, 50519.494805052214, 62969.74060518764, 65515.344846551874, 103742.48128759308, 93202.0, 93588.53205733928, 94491.0550894496, 95017.524912375, 96157.5192124035, 7963.283304502623, 8060.395470339865, 8109.7161599343735, 8225.876611850947, 8272.420930534805, 54477.72761136169, 54534.0, 54599.18101228564, 56791.0, 59104.704476477345, 73959.26040739524, 75198.0, 83900.58049709712, 83940.58029709812, 84544.57727711322, 12071.275723456622, 12359.3820308986, 12368.690782730504, 12774.61676149717, 12943.5469758558, 14559.490417835324, 14955.551333460013, 14971.0, 15349.21776213053, 15495.612609684396, 12335.383230838243, 13116.868831311947, 14427.3507692152, 14708.55874323772, 14865.554033379016, 12697.619071427873, 13266.33668316561, 13268.601941941757, 14596.921730830281, 14674.779878302048, 14193.0, 14236.572902812932, 14262.42950281977, 14527.854721453074, 14544.418223271374, 10210.897891021292, 10478.63324783629, 10654.520546575268, 10679.359238445719, 11127.276727012719, 10132.378819388863, 11095.778084438105, 11784.4696988634, 11826.408679565815, 11921.582744603897], "value": 7449.860845459378, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1580.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 108.0, 112.0, 113.0, 114.0, 119.0, 113.0, 113.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 155.0, 195.0, 129.0, 152.0, 157.0, 123.0, 185.0, 127.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 170.0, 166.0, 192.0, 165.0, 163.0, 164.0, 165.0, 165.0, 165.0], "value": 168.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 181.0, 79.0, 78.0, 76.0, 79.0, 195.0, 78.0], "value": 99.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 87.0, 157.0, 86.0, 86.0, 91.0, 137.0, 86.0, 86.0, 145.0], "value": 106.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 117.0, 118.0, 117.0, 119.0, 119.0, 119.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 150.0, 148.0, 149.0, 147.0, 147.0, 150.0, 155.0, 147.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 54.0, 53.0, 54.0, 57.0, 57.0, 59.0, 55.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 62.0, 62.0, 62.0, 62.0, 63.0, 63.0, 62.0, 64.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 90.0, 83.0, 85.0, 80.0, 81.0, 82.0, 89.0, 79.0, 85.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 129.0, 137.0, 133.0, 127.0, 136.0, 155.0, 130.0, 194.0, 131.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 175.0, 174.0, 170.0, 170.0, 179.0, 167.0, 169.0, 165.0, 187.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 75.0, 68.0, 70.0, 70.0, 66.0, 67.0, 66.0, 66.0], "value": 68.6, "unit": "score"}]}]} 16:34:26 INFO - Return code: 0 16:34:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:34:26 ERROR - # TBPL SUCCESS # 16:34:26 INFO - Running post-action listener: _resource_record_post_action 16:34:26 INFO - [mozharness: 2016-08-21 23:34:26.094748Z] Finished run-tests step (success) 16:34:26 INFO - Running post-run listener: _resource_record_post_run 16:34:26 INFO - Total resource usage - Wall time: 1194s; CPU: 14.0%; Read bytes: 4096; Write bytes: 418512896; Read time: 16; Write time: 260520 16:34:26 INFO - TinderboxPrint: CPU usage
13.9% 16:34:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:34:26 INFO - TinderboxPrint: I/O write bytes / time
418,512,896 / 260,520 16:34:26 INFO - TinderboxPrint: CPU idle
8,197.0 (86.1%) 16:34:26 INFO - TinderboxPrint: CPU user
1,228.4 (12.9%) 16:34:26 INFO - TinderboxPrint: Swap in / out
0 / 0 16:34:26 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118358016; Read time: 0; Write time: 117816 16:34:26 INFO - run-tests - Wall time: 1177s; CPU: 14.0%; Read bytes: 0; Write bytes: 288886784; Read time: 0; Write time: 140284 16:34:26 INFO - Running post-run listener: _upload_blobber_files 16:34:26 INFO - Blob upload gear active. 16:34:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:34:26 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:34:26 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:34:26 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:34:27 INFO - (blobuploader) - INFO - Open directory for files ... 16:34:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:34:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:34:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:27 INFO - (blobuploader) - INFO - Done attempting. 16:34:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:34:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:34:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:31 INFO - (blobuploader) - INFO - Done attempting. 16:34:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:34:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:34:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:32 INFO - (blobuploader) - INFO - Done attempting. 16:34:32 INFO - (blobuploader) - INFO - Iteration through files over. 16:34:32 INFO - Return code: 0 16:34:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:34:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:34:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/59b99783c15d362abe763cf9b709f7bd8de53ff3af528d3bc5e26c277db68fbc41e0cd598f7da4c2ef55fc7c921a19894d170bf9ea70f07ad919ddb6d9f60e47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d94a500055e5ea5486c94167db14ab26693a707154ff17330426cbe0fd660ced98083f18fdab46d389690f32bad525b83b044b4da783a21809852f59250823e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8ec7184fa69963acd6a8c1076de6c9b63f147bfb61c4f4ef21d0f5ddf94b30992b146609a606e13329681ceb2fa80c56bfede2f6c68fb8f9b7595aae7ceee2f8"} 16:34:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:34:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:34:32 INFO - Contents: 16:34:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/59b99783c15d362abe763cf9b709f7bd8de53ff3af528d3bc5e26c277db68fbc41e0cd598f7da4c2ef55fc7c921a19894d170bf9ea70f07ad919ddb6d9f60e47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d94a500055e5ea5486c94167db14ab26693a707154ff17330426cbe0fd660ced98083f18fdab46d389690f32bad525b83b044b4da783a21809852f59250823e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8ec7184fa69963acd6a8c1076de6c9b63f147bfb61c4f4ef21d0f5ddf94b30992b146609a606e13329681ceb2fa80c56bfede2f6c68fb8f9b7595aae7ceee2f8"} 16:34:32 INFO - Running post-run listener: copy_logs_to_upload_dir 16:34:32 INFO - Copying logs to upload dir... 16:34:32 INFO - mkdir: /builds/slave/test/build/upload/logs 16:34:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.391220 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-21 16:34:32.113696) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-21 16:34:32.117407) ========= 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=826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818 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/59b99783c15d362abe763cf9b709f7bd8de53ff3af528d3bc5e26c277db68fbc41e0cd598f7da4c2ef55fc7c921a19894d170bf9ea70f07ad919ddb6d9f60e47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d94a500055e5ea5486c94167db14ab26693a707154ff17330426cbe0fd660ced98083f18fdab46d389690f32bad525b83b044b4da783a21809852f59250823e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8ec7184fa69963acd6a8c1076de6c9b63f147bfb61c4f4ef21d0f5ddf94b30992b146609a606e13329681ceb2fa80c56bfede2f6c68fb8f9b7595aae7ceee2f8"} build_url:https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011391 build_url: 'https://queue.taskcluster.net/v1/task/PIGLcVlQRyGmnYVjLFXY0w/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/59b99783c15d362abe763cf9b709f7bd8de53ff3af528d3bc5e26c277db68fbc41e0cd598f7da4c2ef55fc7c921a19894d170bf9ea70f07ad919ddb6d9f60e47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d94a500055e5ea5486c94167db14ab26693a707154ff17330426cbe0fd660ced98083f18fdab46d389690f32bad525b83b044b4da783a21809852f59250823e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8ec7184fa69963acd6a8c1076de6c9b63f147bfb61c4f4ef21d0f5ddf94b30992b146609a606e13329681ceb2fa80c56bfede2f6c68fb8f9b7595aae7ceee2f8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-21 16:34:32.142736) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 16:34:32.143101) ========= 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=826874ccc97bd7bf541b4875000001d5-1471820475.374539-1902641818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 16:34:32.228712) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-21 16:34:32.229306) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-21 16:34:32.229822) ========= ========= Total master_lag: 0.20 =========