builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1471965171.07 results: success (0) buildid: 20160823065947 builduid: 01ad60674bde4718a17ce71a9ea97517 revision: 352d2e43336522a95c803d25a48c0df63dff931d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 08:12:51.066398) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 08:12:51.067047) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 08:12:51.067348) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 08:12:51.111511) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:12:51.111821) ========= 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=32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-23 08:12:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-08-23 08:12:51 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119431 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:12:51.246730) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:12:51.247101) ========= 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=32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015064 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:12:51.296763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:12:51.297163) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 352d2e43336522a95c803d25a48c0df63dff931d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 352d2e43336522a95c803d25a48c0df63dff931d --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=32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-23 08:12:51,659 truncating revision to first 12 chars 2016-08-23 08:12:51,659 Setting DEBUG logging. 2016-08-23 08:12:51,659 attempt 1/10 2016-08-23 08:12:51,659 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/352d2e433365?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 08:12:51,930 unpacking tar archive at: mozilla-central-352d2e433365/testing/mozharness/ program finished with exit code 0 elapsedTime=0.610431 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:12:51.934398) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 08:12:51.934712) ========= script_repo_revision: 352d2e43336522a95c803d25a48c0df63dff931d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 08:12:51.935115) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 08:12:51.935427) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 08:12:51.970679) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-23 08:12:51.970975) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:12:52 INFO - MultiFileLogger online at 20160823 08:12:52 in /builds/slave/test 08:12:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:12:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:12:52 INFO - {'append_to_log': False, 08:12:52 INFO - 'base_work_dir': '/builds/slave/test', 08:12:52 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:12:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:12:52 INFO - 'branch': 'Firefox-Non-PGO', 08:12:52 INFO - 'buildbot_json_path': 'buildprops.json', 08:12:52 INFO - 'config_files': ('talos/linux_config.py',), 08:12:52 INFO - 'default_actions': ('clobber', 08:12:52 INFO - 'read-buildbot-config', 08:12:52 INFO - 'download-and-extract', 08:12:52 INFO - 'populate-webroot', 08:12:52 INFO - 'create-virtualenv', 08:12:52 INFO - 'install', 08:12:52 INFO - 'run-tests'), 08:12:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:12:52 INFO - 'download_minidump_stackwalk': True, 08:12:52 INFO - 'download_symbols': 'ondemand', 08:12:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:12:52 INFO - 'tooltool.py': '/tools/tooltool.py', 08:12:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:12:52 INFO - '/tools/misc-python/virtualenv.py')}, 08:12:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:12:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:12:52 INFO - 'installer_path': 'installer.exe', 08:12:52 INFO - 'log_level': 'info', 08:12:52 INFO - 'log_name': 'talos', 08:12:52 INFO - 'log_to_console': True, 08:12:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:12:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:12:52 INFO - 'opt_config_files': (), 08:12:52 INFO - 'pip_index': False, 08:12:52 INFO - 'sps_profile': False, 08:12:52 INFO - 'sps_profile_interval': 0, 08:12:52 INFO - 'suite': 'dromaeojs', 08:12:52 INFO - 'system_bits': '32', 08:12:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:12:52 INFO - 'title': 'talos-linux64-ix-008', 08:12:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:12:52 INFO - 'use_talos_json': True, 08:12:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:12:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:12:52 INFO - 'work_dir': 'build'} 08:12:52 INFO - [mozharness: 2016-08-23 15:12:52.425627Z] Running clobber step. 08:12:52 INFO - Running pre-action listener: _resource_record_pre_action 08:12:52 INFO - Running main action method: clobber 08:12:52 INFO - rmtree: /builds/slave/test/build 08:12:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:12:53 INFO - Running post-action listener: _resource_record_post_action 08:12:53 INFO - [mozharness: 2016-08-23 15:12:53.397777Z] Finished clobber step (success) 08:12:53 INFO - [mozharness: 2016-08-23 15:12:53.397876Z] Running read-buildbot-config step. 08:12:53 INFO - Running pre-action listener: _resource_record_pre_action 08:12:53 INFO - Running main action method: read_buildbot_config 08:12:53 INFO - Using buildbot properties: 08:12:53 INFO - { 08:12:53 INFO - "project": "", 08:12:53 INFO - "product": "firefox", 08:12:53 INFO - "script_repo_revision": "production", 08:12:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:12:53 INFO - "repository": "", 08:12:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:12:53 INFO - "buildid": "20160823065947", 08:12:53 INFO - "pgo_build": "False", 08:12:53 INFO - "basedir": "/builds/slave/test", 08:12:53 INFO - "buildnumber": 606, 08:12:53 INFO - "slavename": "talos-linux64-ix-008", 08:12:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:12:53 INFO - "platform": "ubuntu64_hw", 08:12:53 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:12:53 INFO - "branch": "mozilla-central", 08:12:53 INFO - "repo_path": "mozilla-central", 08:12:53 INFO - "revision": "352d2e43336522a95c803d25a48c0df63dff931d", 08:12:53 INFO - "stage_platform": "linux64", 08:12:53 INFO - "builduid": "01ad60674bde4718a17ce71a9ea97517", 08:12:53 INFO - "slavebuilddir": "test" 08:12:53 INFO - } 08:12:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:12:53 INFO - Running post-action listener: _resource_record_post_action 08:12:53 INFO - [mozharness: 2016-08-23 15:12:53.400276Z] Finished read-buildbot-config step (success) 08:12:53 INFO - [mozharness: 2016-08-23 15:12:53.400363Z] Running download-and-extract step. 08:12:53 INFO - Running pre-action listener: _resource_record_pre_action 08:12:53 INFO - Running main action method: download_and_extract 08:12:53 INFO - mkdir: /builds/slave/test/build/tests 08:12: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')]} 08:12:53 INFO - trying https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:12:53 INFO - Downloading https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/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 08:12:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/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 08:12:54 INFO - Downloaded 1361 bytes. 08:12:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:12:54 INFO - Using the following test package requirements: 08:12:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:12:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:12:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:12:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:54 INFO - u'jsshell-linux-x86_64.zip'], 08:12:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:12:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:12:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:12:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:12:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:12:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:12:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:12:54 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')]} 08:12:54 INFO - trying https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:12:54 INFO - Downloading https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/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 08:12:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/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 08:12:54 INFO - Downloaded 20330659 bytes. 08:12:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:12: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 08:12: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')]} 08:12:59 INFO - trying https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:12:59 INFO - Downloading https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/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 08:12:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/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 08:13:00 INFO - Downloaded 20330659 bytes. 08:13: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 08:13: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')]} 08:13:04 INFO - trying https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:13:04 INFO - Downloading https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/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 08:13:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/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 08:13:05 INFO - Downloaded 14413981 bytes. 08:13:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 08:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:05 INFO - trying https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:13:05 INFO - Downloading https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/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 08:13:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/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 08:13:07 INFO - Downloaded 55765496 bytes. 08:13:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:13:07 INFO - mkdir: /builds/slave/test/properties 08:13:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:13:07 INFO - Writing to file /builds/slave/test/properties/build_url 08:13:07 INFO - Contents: 08:13:07 INFO - build_url:https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:13:07 INFO - Running post-action listener: _resource_record_post_action 08:13:07 INFO - Running post-action listener: set_extra_try_arguments 08:13:07 INFO - [mozharness: 2016-08-23 15:13:07.863054Z] Finished download-and-extract step (success) 08:13:07 INFO - [mozharness: 2016-08-23 15:13:07.863277Z] Running populate-webroot step. 08:13:07 INFO - Running pre-action listener: _resource_record_pre_action 08:13:07 INFO - Running main action method: populate_webroot 08:13:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:13:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:13:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:13:07 INFO - '--tppagecycles', 08:13:07 INFO - '7'], 08:13:07 INFO - 'tests': ['tsvgm']}}, 08:13:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:13:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:13:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:13:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:13:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:13:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:13:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:07 INFO - 'talos_options': ['--disable-e10s'], 08:13:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:13:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:13:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:07 INFO - 'talos_options': ['--disable-e10s'], 08:13:07 INFO - 'tests': ['damp', 'tps']}, 08:13:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:07 INFO - 'tests': ['damp', 'tps']}, 08:13:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:13:07 INFO - 'tests': ['dromaeo_dom']}, 08:13:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:13:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:13:07 INFO - 'tests': ['basic_compositor_video']}, 08:13:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:13:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:13:07 INFO - 'tests': ['a11yr', 08:13:07 INFO - 'ts_paint', 08:13:07 INFO - 'tpaint', 08:13:07 INFO - 'sessionrestore', 08:13:07 INFO - 'sessionrestore_no_auto_restore', 08:13:07 INFO - 'tabpaint']}, 08:13:07 INFO - 'other-e10s': {'tests': ['a11yr', 08:13:07 INFO - 'ts_paint', 08:13:07 INFO - 'tpaint', 08:13:07 INFO - 'sessionrestore', 08:13:07 INFO - 'sessionrestore_no_auto_restore', 08:13:07 INFO - 'tabpaint']}, 08:13:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:13:07 INFO - 'ts_paint', 08:13:07 INFO - 'tpaint', 08:13:07 INFO - 'sessionrestore', 08:13:07 INFO - 'sessionrestore_no_auto_restore', 08:13:07 INFO - 'tabpaint']}, 08:13:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:13:07 INFO - 'ts_paint', 08:13:07 INFO - 'tpaint', 08:13:07 INFO - 'sessionrestore', 08:13:07 INFO - 'sessionrestore_no_auto_restore', 08:13:07 INFO - 'tabpaint']}, 08:13:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:13:07 INFO - 'tests': ['a11yr', 08:13:07 INFO - 'ts_paint', 08:13:07 INFO - 'tpaint', 08:13:07 INFO - 'sessionrestore', 08:13:07 INFO - 'sessionrestore_no_auto_restore', 08:13:07 INFO - 'tabpaint']}, 08:13:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:13:07 INFO - 'tests': ['a11yr', 08:13:07 INFO - 'ts_paint', 08:13:07 INFO - 'tpaint', 08:13:07 INFO - 'sessionrestore', 08:13:07 INFO - 'sessionrestore_no_auto_restore', 08:13:07 INFO - 'tabpaint']}, 08:13:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:13:07 INFO - 'tests': ['tsvgx', 08:13:07 INFO - 'tsvgr_opacity', 08:13:07 INFO - 'tart', 08:13:07 INFO - 'tscrollx', 08:13:07 INFO - 'cart']}, 08:13:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:13:07 INFO - 'tsvgr_opacity', 08:13:07 INFO - 'tart', 08:13:07 INFO - 'tscrollx', 08:13:07 INFO - 'cart']}, 08:13:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:07 INFO - 'talos_options': ['--disable-e10s'], 08:13:07 INFO - 'tests': ['tp5o']}, 08:13:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:07 INFO - 'tests': ['tp5o']}, 08:13:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:07 INFO - 'talos_options': ['--disable-e10s', 08:13:07 INFO - '--xperf_path', 08:13:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:13:07 INFO - 'tests': ['tp5n']}, 08:13:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:07 INFO - 'talos_options': ['--xperf_path', 08:13:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:13:07 INFO - 'tests': ['tp5n']}}, 08:13:07 INFO - 'talos.zip': {'path': '', 08:13:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:13:07 INFO - Running post-action listener: _resource_record_post_action 08:13:07 INFO - [mozharness: 2016-08-23 15:13:07.879671Z] Finished populate-webroot step (success) 08:13:07 INFO - [mozharness: 2016-08-23 15:13:07.879758Z] Running create-virtualenv step. 08:13:07 INFO - Running pre-action listener: _resource_record_pre_action 08:13:07 INFO - Running main action method: create_virtualenv 08:13:07 INFO - Creating virtualenv /builds/slave/test/build/venv 08:13:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:13:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:13:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:13:07 INFO - Using real prefix '/usr' 08:13:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:13:08 INFO - Installing distribute.............................................................................................................................................................................................done. 08:13:10 INFO - Installing pip.................done. 08:13:10 INFO - Return code: 0 08:13:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f448d49ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c04090>, '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 0x1c079b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c07e40>, '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': '32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398', '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 08:13:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:13:10 INFO - Using env: {'DISPLAY': ':0', 08:13:10 INFO - 'HOME': '/home/cltbld', 08:13:10 INFO - 'LANG': 'en_US.UTF-8', 08:13:10 INFO - 'LANGUAGE': 'en_US:en', 08:13:10 INFO - 'LOGNAME': 'cltbld', 08:13:10 INFO - 'MAIL': '/var/mail/cltbld', 08:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:10 INFO - 'MOZ_NO_REMOTE': '1', 08:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:10 INFO - 'NO_EM_RESTART': '1', 08:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:10 INFO - 'PWD': '/builds/slave/test', 08:13:10 INFO - 'SHELL': '/bin/bash', 08:13:10 INFO - 'SHLVL': '1', 08:13:10 INFO - 'TERM': 'linux', 08:13:10 INFO - 'TMOUT': '86400', 08:13:10 INFO - 'USER': 'cltbld', 08:13:10 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398', 08:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:10 INFO - '_': '/tools/buildbot/bin/python'} 08:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:13:10 INFO - Cleaning up... 08:13:10 INFO - Return code: 0 08:13:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f448d49ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c04090>, '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 0x1c079b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c07e40>, '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': '32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398', '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 08:13:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:13:10 INFO - Using env: {'DISPLAY': ':0', 08:13:10 INFO - 'HOME': '/home/cltbld', 08:13:10 INFO - 'LANG': 'en_US.UTF-8', 08:13:10 INFO - 'LANGUAGE': 'en_US:en', 08:13:10 INFO - 'LOGNAME': 'cltbld', 08:13:10 INFO - 'MAIL': '/var/mail/cltbld', 08:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:10 INFO - 'MOZ_NO_REMOTE': '1', 08:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:10 INFO - 'NO_EM_RESTART': '1', 08:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:10 INFO - 'PWD': '/builds/slave/test', 08:13:10 INFO - 'SHELL': '/bin/bash', 08:13:10 INFO - 'SHLVL': '1', 08:13:10 INFO - 'TERM': 'linux', 08:13:10 INFO - 'TMOUT': '86400', 08:13:10 INFO - 'USER': 'cltbld', 08:13:10 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398', 08:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:10 INFO - '_': '/tools/buildbot/bin/python'} 08:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:10 INFO - Downloading/unpacking psutil>=3.1.1 08:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:13:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:13:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:13:12 INFO - Installing collected packages: psutil 08:13:12 INFO - Running setup.py install for psutil 08:13:12 INFO - building 'psutil._psutil_linux' extension 08:13:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:13:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:13:13 INFO - building 'psutil._psutil_posix' extension 08:13:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:13:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:13:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:13:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:13:13 INFO - Successfully installed psutil 08:13:13 INFO - Cleaning up... 08:13:13 INFO - Return code: 0 08:13:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f448d49ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c04090>, '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 0x1c079b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c07e40>, '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': '32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398', '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 08:13:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:13:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:13:13 INFO - Using env: {'DISPLAY': ':0', 08:13:13 INFO - 'HOME': '/home/cltbld', 08:13:13 INFO - 'LANG': 'en_US.UTF-8', 08:13:13 INFO - 'LANGUAGE': 'en_US:en', 08:13:13 INFO - 'LOGNAME': 'cltbld', 08:13:13 INFO - 'MAIL': '/var/mail/cltbld', 08:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:13 INFO - 'MOZ_NO_REMOTE': '1', 08:13:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:13 INFO - 'NO_EM_RESTART': '1', 08:13:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:13 INFO - 'PWD': '/builds/slave/test', 08:13:13 INFO - 'SHELL': '/bin/bash', 08:13:13 INFO - 'SHLVL': '1', 08:13:13 INFO - 'TERM': 'linux', 08:13:13 INFO - 'TMOUT': '86400', 08:13:13 INFO - 'USER': 'cltbld', 08:13:13 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398', 08:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:13 INFO - '_': '/tools/buildbot/bin/python'} 08:13:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:13:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:13:15 INFO - Installing collected packages: mozsystemmonitor 08:13:15 INFO - Running setup.py install for mozsystemmonitor 08:13:15 INFO - Successfully installed mozsystemmonitor 08:13:15 INFO - Cleaning up... 08:13:15 INFO - Return code: 0 08:13:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:13: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')]} 08:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13: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')]} 08:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f448d49ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c04090>, '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 0x1c079b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c07e40>, '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': '32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398', '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 08:13:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:13:15 INFO - Using env: {'DISPLAY': ':0', 08:13:15 INFO - 'HOME': '/home/cltbld', 08:13:15 INFO - 'LANG': 'en_US.UTF-8', 08:13:15 INFO - 'LANGUAGE': 'en_US:en', 08:13:15 INFO - 'LOGNAME': 'cltbld', 08:13:15 INFO - 'MAIL': '/var/mail/cltbld', 08:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:15 INFO - 'MOZ_NO_REMOTE': '1', 08:13:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:15 INFO - 'NO_EM_RESTART': '1', 08:13:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:15 INFO - 'PWD': '/builds/slave/test', 08:13:15 INFO - 'SHELL': '/bin/bash', 08:13:15 INFO - 'SHLVL': '1', 08:13:15 INFO - 'TERM': 'linux', 08:13:15 INFO - 'TMOUT': '86400', 08:13:15 INFO - 'USER': 'cltbld', 08:13:15 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398', 08:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:15 INFO - '_': '/tools/buildbot/bin/python'} 08:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:15 INFO - Downloading/unpacking jsonschema==2.5.1 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:13:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13:18 INFO - Downloading functools32-3.2.3-2.tar.gz 08:13:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:13:18 INFO - warning: no files found matching '*.txt' 08:13:18 INFO - no previously-included directories found matching 'build' 08:13:18 INFO - no previously-included directories found matching 'dist' 08:13:18 INFO - no previously-included directories found matching '.git*' 08:13:18 INFO - Installing collected packages: jsonschema, functools32 08:13:18 INFO - Running setup.py install for functools32 08:13:18 INFO - warning: no files found matching '*.txt' 08:13:18 INFO - no previously-included directories found matching 'build' 08:13:18 INFO - no previously-included directories found matching 'dist' 08:13:18 INFO - no previously-included directories found matching '.git*' 08:13:18 INFO - Successfully installed jsonschema functools32 08:13:18 INFO - Cleaning up... 08:13:18 INFO - Return code: 0 08:13:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f448d49ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c04090>, '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 0x1c079b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c07e40>, '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': '32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398', '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 08:13:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:13:18 INFO - Using env: {'DISPLAY': ':0', 08:13:18 INFO - 'HOME': '/home/cltbld', 08:13:18 INFO - 'LANG': 'en_US.UTF-8', 08:13:18 INFO - 'LANGUAGE': 'en_US:en', 08:13:18 INFO - 'LOGNAME': 'cltbld', 08:13:18 INFO - 'MAIL': '/var/mail/cltbld', 08:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:18 INFO - 'MOZ_NO_REMOTE': '1', 08:13:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:18 INFO - 'NO_EM_RESTART': '1', 08:13:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:18 INFO - 'PWD': '/builds/slave/test', 08:13:18 INFO - 'SHELL': '/bin/bash', 08:13:18 INFO - 'SHLVL': '1', 08:13:18 INFO - 'TERM': 'linux', 08:13:18 INFO - 'TMOUT': '86400', 08:13:18 INFO - 'USER': 'cltbld', 08:13:18 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398', 08:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:18 INFO - '_': '/tools/buildbot/bin/python'} 08:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:13:18 INFO - Cleaning up... 08:13:18 INFO - Return code: 0 08:13:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f448d49ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c04090>, '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 0x1c079b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c07e40>, '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': '32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398', '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 08:13:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:13:18 INFO - Using env: {'DISPLAY': ':0', 08:13:18 INFO - 'HOME': '/home/cltbld', 08:13:18 INFO - 'LANG': 'en_US.UTF-8', 08:13:18 INFO - 'LANGUAGE': 'en_US:en', 08:13:18 INFO - 'LOGNAME': 'cltbld', 08:13:18 INFO - 'MAIL': '/var/mail/cltbld', 08:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:18 INFO - 'MOZ_NO_REMOTE': '1', 08:13:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:18 INFO - 'NO_EM_RESTART': '1', 08:13:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:18 INFO - 'PWD': '/builds/slave/test', 08:13:18 INFO - 'SHELL': '/bin/bash', 08:13:18 INFO - 'SHLVL': '1', 08:13:18 INFO - 'TERM': 'linux', 08:13:18 INFO - 'TMOUT': '86400', 08:13:18 INFO - 'USER': 'cltbld', 08:13:18 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398', 08:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:18 INFO - '_': '/tools/buildbot/bin/python'} 08:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:18 INFO - Downloading/unpacking blobuploader==1.2.4 08:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:20 INFO - Downloading blobuploader-1.2.4.tar.gz 08:13:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:13:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:13:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:21 INFO - Downloading docopt-0.6.1.tar.gz 08:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:13:21 INFO - Installing collected packages: blobuploader, requests, docopt 08:13:21 INFO - Running setup.py install for blobuploader 08:13:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:13:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:13:21 INFO - Running setup.py install for requests 08:13:21 INFO - Running setup.py install for docopt 08:13:21 INFO - Successfully installed blobuploader requests docopt 08:13:21 INFO - Cleaning up... 08:13:22 INFO - Return code: 0 08:13:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:22 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 0x7f448d49ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c04090>, '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 0x1c079b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c07e40>, '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': '32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398', '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 08:13:22 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 08:13:22 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 08:13:22 INFO - Using env: {'DISPLAY': ':0', 08:13:22 INFO - 'HOME': '/home/cltbld', 08:13:22 INFO - 'LANG': 'en_US.UTF-8', 08:13:22 INFO - 'LANGUAGE': 'en_US:en', 08:13:22 INFO - 'LOGNAME': 'cltbld', 08:13:22 INFO - 'MAIL': '/var/mail/cltbld', 08:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:22 INFO - 'MOZ_NO_REMOTE': '1', 08:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:22 INFO - 'NO_EM_RESTART': '1', 08:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:22 INFO - 'PWD': '/builds/slave/test', 08:13:22 INFO - 'SHELL': '/bin/bash', 08:13:22 INFO - 'SHLVL': '1', 08:13:22 INFO - 'TERM': 'linux', 08:13:22 INFO - 'TMOUT': '86400', 08:13:22 INFO - 'USER': 'cltbld', 08:13:22 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398', 08:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:22 INFO - '_': '/tools/buildbot/bin/python'} 08:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:13:22 INFO - Running setup.py (path:/tmp/pip-9DHIQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:13:22 INFO - Running setup.py (path:/tmp/pip-SI49md-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:13:22 INFO - Running setup.py (path:/tmp/pip-euHzxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:13:22 INFO - Running setup.py (path:/tmp/pip-B3T2af-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:13:22 INFO - Running setup.py (path:/tmp/pip-ZtEt9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:13:22 INFO - Running setup.py (path:/tmp/pip-MHCQIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:13:22 INFO - Running setup.py (path:/tmp/pip-QNKKGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:13:22 INFO - Running setup.py (path:/tmp/pip-1eL1vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:13:22 INFO - Running setup.py (path:/tmp/pip-fcTbX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:13:22 INFO - Running setup.py (path:/tmp/pip-K2Xeor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:13:22 INFO - Running setup.py (path:/tmp/pip-WRAYSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:13:23 INFO - Running setup.py (path:/tmp/pip-d_r9aX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:13:23 INFO - Running setup.py (path:/tmp/pip-ExQrfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:13:23 INFO - Running setup.py (path:/tmp/pip-ip_1pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:23 INFO - Running setup.py (path:/tmp/pip-pV1ul2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:13:23 INFO - Running setup.py (path:/tmp/pip-GAlPJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:13:23 INFO - Running setup.py (path:/tmp/pip-POue2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:13:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:13:23 INFO - Running setup.py install for manifestparser 08:13:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:13:23 INFO - Running setup.py install for mozcrash 08:13:23 INFO - Running setup.py install for mozdebug 08:13:23 INFO - Running setup.py install for mozdevice 08:13:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:13:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:13:23 INFO - Running setup.py install for mozfile 08:13:23 INFO - Running setup.py install for mozhttpd 08:13:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:13:24 INFO - Running setup.py install for mozinfo 08:13:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:13:24 INFO - Running setup.py install for mozInstall 08:13:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:13:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:13:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:13:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:13:24 INFO - Running setup.py install for mozleak 08:13:24 INFO - Running setup.py install for mozlog 08:13:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:13:24 INFO - Running setup.py install for moznetwork 08:13:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:13:24 INFO - Running setup.py install for mozprocess 08:13:24 INFO - Running setup.py install for mozprofile 08:13:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:13:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:13:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:13:24 INFO - Running setup.py install for mozrunner 08:13:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:13:24 INFO - Running setup.py install for mozscreenshot 08:13:25 INFO - Running setup.py install for moztest 08:13:25 INFO - Running setup.py install for mozversion 08:13:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:13:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:13:25 INFO - Cleaning up... 08:13:25 INFO - Return code: 0 08:13:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f448d49ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c04090>, '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 0x1c079b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c07e40>, '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': '32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398', '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 08:13:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:13:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:13:25 INFO - Using env: {'DISPLAY': ':0', 08:13:25 INFO - 'HOME': '/home/cltbld', 08:13:25 INFO - 'LANG': 'en_US.UTF-8', 08:13:25 INFO - 'LANGUAGE': 'en_US:en', 08:13:25 INFO - 'LOGNAME': 'cltbld', 08:13:25 INFO - 'MAIL': '/var/mail/cltbld', 08:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:25 INFO - 'MOZ_NO_REMOTE': '1', 08:13:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:25 INFO - 'NO_EM_RESTART': '1', 08:13:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:25 INFO - 'PWD': '/builds/slave/test', 08:13:25 INFO - 'SHELL': '/bin/bash', 08:13:25 INFO - 'SHLVL': '1', 08:13:25 INFO - 'TERM': 'linux', 08:13:25 INFO - 'TMOUT': '86400', 08:13:25 INFO - 'USER': 'cltbld', 08:13:25 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398', 08:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:25 INFO - '_': '/tools/buildbot/bin/python'} 08:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:13:25 INFO - Running setup.py (path:/tmp/pip-Qfa86e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:13:25 INFO - Running setup.py (path:/tmp/pip-9L2ZDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:13:25 INFO - Running setup.py (path:/tmp/pip-ILFgLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:13:25 INFO - Running setup.py (path:/tmp/pip-zL22Le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:13:25 INFO - Running setup.py (path:/tmp/pip-NK5eqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:13:25 INFO - Running setup.py (path:/tmp/pip-cVb4Cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:13:25 INFO - Running setup.py (path:/tmp/pip-LHHiwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:13:25 INFO - Running setup.py (path:/tmp/pip-gLHIEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:13:26 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)) 08:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:13:26 INFO - Running setup.py (path:/tmp/pip-WvqpII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:13:26 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)) 08:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:13:26 INFO - Running setup.py (path:/tmp/pip-SjpC2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:13:26 INFO - Running setup.py (path:/tmp/pip-WDWsQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:13:26 INFO - Running setup.py (path:/tmp/pip-gNOoYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:13:26 INFO - Running setup.py (path:/tmp/pip-mGnBFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:13:26 INFO - Running setup.py (path:/tmp/pip-ofttgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:26 INFO - Running setup.py (path:/tmp/pip-KpAfnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:13:26 INFO - Running setup.py (path:/tmp/pip-NnbnUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:13:26 INFO - Running setup.py (path:/tmp/pip-JGmVnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:13:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:28 INFO - Downloading blessings-1.6.tar.gz 08:13:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:13:28 INFO - Installing collected packages: blessings 08:13:28 INFO - Running setup.py install for blessings 08:13:28 INFO - Successfully installed blessings 08:13:28 INFO - Cleaning up... 08:13:28 INFO - Return code: 0 08:13:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:13:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:13:28 INFO - Reading from file tmpfile_stdout 08:13:28 INFO - Current package versions: 08:13:28 INFO - argparse == 1.2.1 08:13:28 INFO - blessings == 1.6 08:13:28 INFO - blobuploader == 1.2.4 08:13:28 INFO - docopt == 0.6.1 08:13:28 INFO - functools32 == 3.2.3-2 08:13:28 INFO - jsonschema == 2.5.1 08:13:28 INFO - manifestparser == 1.1 08:13:28 INFO - mozInstall == 1.12 08:13:28 INFO - mozcrash == 0.17 08:13:28 INFO - mozdebug == 0.1 08:13:28 INFO - mozdevice == 0.48 08:13:28 INFO - mozfile == 1.2 08:13:28 INFO - mozhttpd == 0.7 08:13:28 INFO - mozinfo == 0.9 08:13:28 INFO - mozleak == 0.1 08:13:28 INFO - mozlog == 3.3 08:13:28 INFO - moznetwork == 0.27 08:13:28 INFO - mozprocess == 0.23 08:13:28 INFO - mozprofile == 0.28 08:13:28 INFO - mozrunner == 6.12 08:13:28 INFO - mozscreenshot == 0.1 08:13:28 INFO - mozsystemmonitor == 0.3 08:13:28 INFO - moztest == 0.7 08:13:28 INFO - mozversion == 1.4 08:13:28 INFO - psutil == 3.1.1 08:13:28 INFO - requests == 1.2.3 08:13:28 INFO - wsgiref == 0.1.2 08:13:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f448d49ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c04090>, '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 0x1c079b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c07e40>, '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': '32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398', '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 08:13:29 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 08:13:29 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 08:13:29 INFO - Using env: {'DISPLAY': ':0', 08:13:29 INFO - 'HOME': '/home/cltbld', 08:13:29 INFO - 'LANG': 'en_US.UTF-8', 08:13:29 INFO - 'LANGUAGE': 'en_US:en', 08:13:29 INFO - 'LOGNAME': 'cltbld', 08:13:29 INFO - 'MAIL': '/var/mail/cltbld', 08:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:29 INFO - 'MOZ_NO_REMOTE': '1', 08:13:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:29 INFO - 'NO_EM_RESTART': '1', 08:13:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:29 INFO - 'PWD': '/builds/slave/test', 08:13:29 INFO - 'SHELL': '/bin/bash', 08:13:29 INFO - 'SHLVL': '1', 08:13:29 INFO - 'TERM': 'linux', 08:13:29 INFO - 'TMOUT': '86400', 08:13:29 INFO - 'USER': 'cltbld', 08:13:29 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398', 08:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:29 INFO - '_': '/tools/buildbot/bin/python'} 08:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:13:29 INFO - Cleaning up... 08:13:29 INFO - Return code: 0 08:13:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:13:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f448d49ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c04090>, '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 0x1c079b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c07e40>, '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': '32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398', '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 08:13:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:13:29 INFO - Using env: {'DISPLAY': ':0', 08:13:29 INFO - 'HOME': '/home/cltbld', 08:13:29 INFO - 'LANG': 'en_US.UTF-8', 08:13:29 INFO - 'LANGUAGE': 'en_US:en', 08:13:29 INFO - 'LOGNAME': 'cltbld', 08:13:29 INFO - 'MAIL': '/var/mail/cltbld', 08:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:29 INFO - 'MOZ_NO_REMOTE': '1', 08:13:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:29 INFO - 'NO_EM_RESTART': '1', 08:13:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:29 INFO - 'PWD': '/builds/slave/test', 08:13:29 INFO - 'SHELL': '/bin/bash', 08:13:29 INFO - 'SHLVL': '1', 08:13:29 INFO - 'TERM': 'linux', 08:13:29 INFO - 'TMOUT': '86400', 08:13:29 INFO - 'USER': 'cltbld', 08:13:29 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398', 08:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:29 INFO - '_': '/tools/buildbot/bin/python'} 08:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:13:29 INFO - Cleaning up... 08:13:29 INFO - Return code: 0 08:13:29 INFO - Running post-action listener: _resource_record_post_action 08:13:29 INFO - Running post-action listener: _start_resource_monitoring 08:13:29 INFO - Starting resource monitoring. 08:13:29 INFO - [mozharness: 2016-08-23 15:13:29.473338Z] Finished create-virtualenv step (success) 08:13:29 INFO - [mozharness: 2016-08-23 15:13:29.473803Z] Running install step. 08:13:29 INFO - Running pre-action listener: _resource_record_pre_action 08:13:29 INFO - Running main action method: install 08:13:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:13:29 INFO - Reading from file tmpfile_stdout 08:13:29 INFO - Detecting whether we're running mozinstall >=1.0... 08:13:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:13:29 INFO - Reading from file tmpfile_stdout 08:13:29 INFO - Output received: 08:13:29 INFO - Usage: mozinstall [options] installer 08:13:29 INFO - Options: 08:13:29 INFO - -h, --help show this help message and exit 08:13:29 INFO - -d DEST, --destination=DEST 08:13:29 INFO - Directory to install application into. [default: 08:13:29 INFO - "/builds/slave/test"] 08:13:29 INFO - --app=APP Application being installed. [default: firefox] 08:13:29 INFO - mkdir: /builds/slave/test/build/application 08:13:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:13:45 INFO - Reading from file tmpfile_stdout 08:13:45 INFO - Output received: 08:13:45 INFO - /builds/slave/test/build/application/firefox/firefox 08:13:45 INFO - Running post-action listener: _resource_record_post_action 08:13:45 INFO - [mozharness: 2016-08-23 15:13:45.884962Z] Finished install step (success) 08:13:45 INFO - [mozharness: 2016-08-23 15:13:45.885210Z] Running run-tests step. 08:13:45 INFO - Running pre-action listener: _resource_record_pre_action 08:13:45 INFO - Running main action method: run_tests 08:13:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:13:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:13:45 INFO - Python 2.7.3 08:13:45 INFO - Return code: 0 08:13:45 INFO - grabbing minidump binary from tooltool 08:13:45 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')]} 08:13:45 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 0x1c04090>, '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 0x1c079b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c07e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:13:45 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 08:13:45 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 08:13:45 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 08:13:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:13:45 INFO - Return code: 0 08:13:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:13:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:13:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:13:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:13:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:13:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:13:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:13:45 INFO - Using env: {'DISPLAY': ':0', 08:13:45 INFO - 'HOME': '/home/cltbld', 08:13:45 INFO - 'LANG': 'en_US.UTF-8', 08:13:45 INFO - 'LANGUAGE': 'en_US:en', 08:13:45 INFO - 'LOGNAME': 'cltbld', 08:13:45 INFO - 'MAIL': '/var/mail/cltbld', 08:13:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:13:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:45 INFO - 'MOZ_NO_REMOTE': '1', 08:13:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:13:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:45 INFO - 'NO_EM_RESTART': '1', 08:13:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:45 INFO - 'PWD': '/builds/slave/test', 08:13:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:13:45 INFO - 'SHELL': '/bin/bash', 08:13:45 INFO - 'SHLVL': '1', 08:13:45 INFO - 'TERM': 'linux', 08:13:45 INFO - 'TMOUT': '86400', 08:13:45 INFO - 'USER': 'cltbld', 08:13:45 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398', 08:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:45 INFO - '_': '/tools/buildbot/bin/python'} 08:13:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:13:46 INFO - mozversion application_buildid: 20160823065947 08:13:46 INFO - mozversion application_changeset: 352d2e43336522a95c803d25a48c0df63dff931d 08:13:46 INFO - mozversion application_display_name: Nightly 08:13:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:13:46 INFO - mozversion application_name: Firefox 08:13:46 INFO - mozversion application_remotingname: firefox 08:13:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:13:46 INFO - mozversion application_vendor: Mozilla 08:13:46 INFO - mozversion application_version: 51.0a1 08:13:46 INFO - mozversion platform_buildid: 20160823065947 08:13:46 INFO - mozversion platform_changeset: 352d2e43336522a95c803d25a48c0df63dff931d 08:13:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:13:46 INFO - mozversion platform_version: 51.0a1 08:13:46 INFO - using testdate: 1471965226 08:13:46 INFO - actual date: 1471965226 08:13:46 INFO - starting webserver on 'localhost:43454' 08:13:46 INFO - SUITE-START | Running 2 tests 08:13:46 INFO - TEST-START | dromaeo_css 08:13:46 INFO - operating with platform_type : linux_ 08:13:46 INFO - Initialising browser for dromaeo_css test... 08:13:46 INFO - TEST-INFO | started process 9674 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkB5dN_/profile http://localhost:43454/getInfo.html) 08:13:50 INFO - PROCESS | 9674 | __metrics Screen width/height:1600/1200 08:13:50 INFO - PROCESS | 9674 | colorDepth:24 08:13:50 INFO - PROCESS | 9674 | Browser inner width/height: 1024/697 08:13:50 INFO - PROCESS | 9674 | __metrics 08:13:51 INFO - PROCESS | 9674 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:13:51 INFO - PROCESS | 9674 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:13:52 INFO - PROCESS | 9674 | console.error: PushService: 08:13:52 INFO - PROCESS | 9674 | stateChangeProcessEnqueue: Error transitioning state 08:13:52 INFO - PROCESS | 9674 | UnknownError 08:13:52 INFO - TEST-INFO | 9674: exit 0 08:13:52 INFO - Browser initialized. 08:13:52 INFO - Running cycle 1/1 for dromaeo_css test... 08:13:52 INFO - TEST-INFO | started process 9754 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkB5dN_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:05 INFO - PROCESS | 9754 | RSS: Main: 175673344 08:14:05 INFO - PROCESS | 9754 | 08:14:56 INFO - PROCESS | 9754 | 1471965296988 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] 08:17:09 INFO - PROCESS | 9754 | Cycle 1(1): loaded http://localhost:43454/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43454/tests/dromaeo/cssquery-ext.html) 08:17:10 INFO - PROCESS | 9754 | RSS: Main: 269578240 08:17:10 INFO - PROCESS | 9754 | 08:20:13 INFO - PROCESS | 9754 | Cycle 1(1): loaded http://localhost:43454/tests/dromaeo/cssquery-ext.html (next: http://localhost:43454/tests/dromaeo/cssquery-jquery.html) 08:20:13 INFO - PROCESS | 9754 | RSS: Main: 278306816 08:20:13 INFO - PROCESS | 9754 | 08:23:16 INFO - PROCESS | 9754 | Cycle 1(1): loaded http://localhost:43454/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43454/tests/dromaeo/cssquery-mootools.html) 08:23:16 INFO - PROCESS | 9754 | RSS: Main: 242548736 08:23:16 INFO - PROCESS | 9754 | 08:26:19 INFO - PROCESS | 9754 | Cycle 1(1): loaded http://localhost:43454/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43454/tests/dromaeo/cssquery-prototype.html) 08:26:20 INFO - PROCESS | 9754 | RSS: Main: 217448448 08:26:20 INFO - PROCESS | 9754 | 08:29:23 INFO - PROCESS | 9754 | Cycle 1(1): loaded http://localhost:43454/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43454/tests/dromaeo/cssquery-yui.html) 08:29:23 INFO - PROCESS | 9754 | RSS: Main: 218079232 08:29:23 INFO - PROCESS | 9754 | 08:32:27 INFO - PROCESS | 9754 | Cycle 1(1): loaded http://localhost:43454/tests/dromaeo/cssquery-yui.html (next: http://localhost:43454/tests/dromaeo/cssquery-dojo.html) 08:32:27 INFO - PROCESS | 9754 | RSS: Main: 286965760 08:32:27 INFO - PROCESS | 9754 | 08:32:27 INFO - PROCESS | 9754 | __start_tp_report 08:32:27 INFO - PROCESS | 9754 | _x_x_mozilla_page_load 08:32:27 INFO - PROCESS | 9754 | _x_x_mozilla_page_load_details 08:32:27 INFO - PROCESS | 9754 | |i|pagename|runs| 08:32:27 INFO - PROCESS | 9754 | |0;dojo.html;2578.6647735794345;2605.7654811067;2619.777318927891;2619.816612837101;2633.525965326242;4579.198640237953;4643.605293550048;4702.8118875244945;4742.288656701497;4743.288506723989;4653.3717948077;4724.692894961825;4750.026244619853;4813.350197723306;4851.975740121304;4142.855000074998;4358.0848021915435;4426.712263702865;4441.711288766236;4442;4398.340248962665;4422.270325396305;4439.089986552749;4446.622037126848;4472.44094488189;4214.936775948363;4246.766427846467;4274.850380236708;4350.499692535367;4357.84747533838;4256.2338779019765;4256.616904478581;4264.23243816113;4279.786010699452;4330.956690433087;4271.145770845812;4277.786110694453;4289.592488713599;4330.675199360029;4348;4727.739974301412;4740.265258884879;4740.715557066587;4741.549552792514;4747;4899.755012249373;4969.652124351297;4975.875603109915;5024.371953505812;5116.386033675945;5103.897922041576;5109.489051094898;5114.335136432277;5128.589712822965;5141.228815677641;4596.17268891596;4764.571188593043;4776.331313616097;4789.568938795525;4797.136515427187;5109.846704598868;5111.948880511221;5166.61250406221;5197.194434862602;5267.0256002639635;5040.521150490697;5041.697498150123;5043.0922433961505;5046;5047.545720885138;4941.530554597308;5108.106081435808;5112.744362781846;5118.769655365518;5122.513361230677;4922.187839006596;4938.283948827472;4991.550760431579;5087.084324821493;5091.287219789232;5039.092963266574;5041.218611115283;5047.293378926953;5058.494150584986;5063.11395505785;4200.726952748061;4367.475902891673;4380.540043295472;4384.583464570861;4391.604755572014;3696.6488183622514;3744.9812750936617;3763.5295588051495;3784.2053168834304;3832.865849695303;4319.632831209319;4342.934855977162;4345.109252603209;4350.564943505624;4351.042770590465;4869.780859861315;5073.923891141636;5076.6192535559985;5082.822101226439;5085.160948443466;4288.48538175421;4327.82688692455;4333.609975102193;4378.912421751611;4388.188185185751;4582.747948862778;4598.448186217675;4601.263797792337;4615.353850460938;4615.9076818463445;4572.222722137178;4758.595519380891;4767.237242041257;4770.356001939694;4775.044991001883;4925.827596034122;4975.875603109951;4991.276264941635;5038.496150384932;5057.14028615129;4738.810447582058;4745.217039188496;4745.549172828576;4754.381930349171;4759.476457589732;4762.476127626028;4965.627577931742;4981.3026176334615;4987.875303117451;4989.925151122663;4927.975360123177;4964.826231081895;4969.776360063878;5002.624803139852;5017.749112544285;4929.950700492949;4934;4938.43208031081;4939.7036177828;4941.851744447672;4711.78796954131;4922.483139270468;4945.901081978413;4953.331300274417;4957.03337849116;4718.787654555485;4739.668223224479;4739.976300118616;4800.039992001543;4817.759112044454;4912.852614421573;4919.950800491949;4934.259861020875;4936.3089167515855;4951.9752401237765;4731.337612734151;4829.830955916526;4836.202026665702;4846.36997190363;4850.7817148227705 08:32:27 INFO - PROCESS | 9754 | |1;ext.html;552.4420335461184;558.983230503085;567.5176100314732;568.428729127227;572.3818276261638;29094.127176184695;39819.40270895935;41019.79490102545;41101.38347924784;44515.554844451544;40003;40375.39436908449;40375.59624403755;40411;40472.190556188856;7041.507094503387;7691.1924247954;7814.882776758353;7862.921370786276;7864.05631324239;9815.116639502443;10080.09279164875;10109.59561617538;10462.163026957825;10477.26659133861;10128.949355253213;10224.795504089914;10226.846597301046;10233.130183934374;10252.794944101113;10072.446015469182;10073.647422340257;10108.696739097766;10130.138938190263;10130.949345253264;9864.704058878246;9895.802083958353;9933.850992235122;9938.403695778277;9944.45305508204;37348.62651373479;37750.24499509994;37792.81103594492;37800.81099594484;37801.24397512034;2722.8366298022183;2826.109775420736;2827.7172282771558;2870.626818513601;3106.0060780550234;28003.289227778983;29005.608874485853;29752.40495190084;29811.850940745375;29815.552766708515;3319.6514365991707;3356.4461863792444;3463.6363181865795;3465.6187819339852;3503.4774962027554;248997;250352;250829;251013;251030;30939.0718278452;53918.65203369869;54397.72801135969;54530.72734636301;54532.45467545353;31381;33095.18690911299;33095.33809323848;33105.337893242;33266.66733332684;12131.393430328448;12315.815262771066;12320.137590368768;12322.383880805924;12329.50681972729;9104.544772761335;9521.23830093591;9650.227981761442;9699.272554558294;9753.658621948198;7771.417143714131;7779.844403111906;7813.621135869852;7825.686972521035;7907.802304942307;3060.540918862144;3063.387322535502;3070.815751054944;3076.461619216628;3105.0995211388895;855.7603870916154;907.4963395315663;929.8330595103102;984.9359791613665;1024.9231307651955;26965.001722700414;27958.720412796018;28093.297667558065;28229.71770282312;28690.713092868806;957.2294303085944;964.8986856379979;1019.2559431614962;1023.9692809215586;1055.6094245129198;14863.777043344358;14880.330385132478;14986.775198372034;15064.171470569225;15105.924470377578;354310;359549;360408;360455;361707;48819.75590122027;49195.754021229666;49288.75355623199;49358.753206234454;49483.288753343644;1059.5496913811598;1066.9466526673634;1089.743910181091;1141.7944769941491;1198.4487135917402;25550.616740748534;29145.688444019645;29791.404171916005;29978.25054373658;30011.69988300089;35700.821495892356;35928.4610730834;36015.63984360123;36018.8199059003;36048.63951360558;275121;276795;276808;277114;277131;24479.632805507576;24749.505009900062;25595.6160657594;25636.61545076788;26987.46025079448;41127.58872411357;41288.793556032026;41496.37755433731;41532.37701434542;42436.36345454759;35678.10804729799;36035;36074.819625901706;36098.819505902306;36102;35852;36019.45970810492;36080.27839443249;36457.27085458223;36543.63456365402;35419;36229.27541449209;36316.27367452583;36687;36689.79861208229;30451.847740761154;32943.34113317672;33152;33184.66815331912;33463;24878;25169.87415062913;25214.74785252124;25660.615090774027;25847.483050338513 08:32:27 INFO - PROCESS | 9754 | |2;jquery.html;345.7147853021255;361.472250514249;362.87480819117405;364.17150981517045;388.1635076410335;12708.555200567971;16021.439249626266;16452.25964831581;17925.551861203476;18108.63782724345;13781.655458613539;13883.861161388382;16423.178841057957;16533.83466165341;16560.503184904443;4907.288443175728;4941.901161976758;5107.642465027431;5134.332536770234;5178.446466060186;3697.1866189438415;5022.146235140035;5104.081265372231;5106.131957567222;5677.659340439587;5904.911426328608;5970.582059255854;5982.8504287392725;5989.251343582052;5995.160677505131;5866.592017915691;5962.5528085393335;5977.342492325841;6040.728167232485;6042.848928776772;5273.077211488013;5276.287701160332;5277.894442111175;5278.10272253714;5280.603954703374;20371.287004954756;20753.688694669592;20980;21181.5763684727;21302.36092917215;1904.190718944443;1937.4962509747568;2061.4331058958905;2079.9376018719463;2577.2965677396387;13177.670558236025;13211.471541138439;13393.19640821544;13396.263205523692;13959.417507760994;1690.484402257311;1711.0674682298177;1722.1991773825107;1733.7139372003605;1812.8730988830787;44237;66458.3354166457;70650.64674676645;70653.2934670657;72888.63555682241;9991.950040249752;10166.593336266615;10252.333598316085;10254.333468324536;11055.72360690989;14166.504172353918;14235.78646320306;14258.500952466615;14270.500532481521;14286.999910006407;6905.274946130685;7202.855942881113;7279.235680253603;7323.523970941872;7349.77950661481;6615.966920165464;6633.568818026813;6674.16572928384;6846.691898864563;6871.244163142051;4222.239996800606;4234;4397.0985947881245;4454.131444368382;4547.113312904018;1706.7781188445672;1806.900620465887;1834.4038187589088;1886.0946745562208;1893.2616279650672;703.8134894253027;804.9154838741965;818.6970820796344;847.2967437027253;879.2877769006997;16234.837651623333;17316.65366692659;17502.299908003537;17569.121543922753;17824.643507130044;836.5022811427191;848.9660413583388;852.5140669818268;876.1763941894599;877.5392918717724;8973.192412682889;9858.112769850748;9902.207823374112;9922.553485093189;10054;382786;384654;385295;393686;399886;49019.26471102936;51055.744721276154;74864.62567687235;83135.33729325501;84759;923.3351986569659;943.5188054092463;946.3801210207188;953.7043516509904;958.9328746987784;15763.921180394025;16010.759838602196;16146.757798632794;16335.346586136422;16525.83474165243;37897.62102379051;38181;38272.61727382691;38465.2306953865;39242.215155696154;51396;55091.17363239635;55148;55601;56151;6504.772332968323;6816.522843400914;7313.597752123685;7505.849883002418;7509.17399086111;10182.185425166117;11263.66209013731;11330.320180789178;11367.896939065968;11799.410029498318;9393.671221507215;9621.759456013375;9642.276829237695;9956;10232.02795734404;10075.445850478294;10289.250827359218;10347.223958203014;10472.790544189225;10943;9235.1688348049;9719.562619682272;9868.506574671093;10111.191104711459;10130.544125514221;7422;7434.442416818868;7453.552786832807;7630.389568834591;7944.285014348737;7666.6166691664075;9647.807043859224;10256.641017564349;10274.897251027693;10471.42407167613 08:32:27 INFO - PROCESS | 9754 | |3;mootools.html;1358.8233529641143;1396.225095072235;1451.6008097773117;1635.2641311409868;1663.5342104210824;6691.933080669191;6946.062281591983;7250.093738282715;7800.141984381714;7834.05991281047;7382.7785166444955;7705.460617756759;7706.653200605972;7941.245581669732;7951.72168974086;2161.146347192858;2181.923632672857;2191.1345018717598;2194.8024677779;2195.9341219763432;1869.0654672663668;2040.1839264294254;2098.6117568249847;2121.9363419097454;2167.5881582499355;2153.3001774423296;2184.541246338271;2189.397915573214;2189.6934429179846;2190.6385446401405;2066.2148383614203;2082.9895850520725;2112.6830975353664;2113.38711773587;2113.778053304396;2062.6596611559075;2068.6690129579197;2070.7411573553304;2082.739657542807;2083.270855200683;7757.5733334666575;7788.6884524618945;7815.687372505093;7830;7848.882266766003;4281.48622165339;4427.557244275579;4438.778061096965;4442.466903971512;4453.643708503312;2846.131929761422;2958.8076775009554;2999.100269919016;3004.1137864330076;3012.412579546989;909.2407839454064;937.8265020971143;956.7321150077989;973.0998826085913;976.3604838830578;10448.111910487542;10476.58093676252;10482.213833962483;10501.264911456201;10511.684649460529;3633.237020225782;3928.8821335359985;4042.0501182222156;4054.533728621246;4057.9797101014306;9116.680916168036;9126.224270937044;9132.452052876848;9132.771680708036;9140.040295768982;4420.823167073346;4423.358613001097;4425.247707889666;4427.867163985085;4444.511103778646;3979.8806035818393;4012.6388625023887;4020.577839326829;4028.133951200506;4062.045419326456;3526.594441639193;3591.9102022449647;3639.1448009717697;3751.6248375162268;3762.435634654824;1065.7655315830505;1124.578283143821;1165.7143999719954;1180.7461395799944;1217.0324591949422;695.6452209373256;708.1431467923767;722.1262272650047;728.1480667618898;768.7040489411505;4963.305137280783;5100.438951715309;5213.739313034409;5248.606354523426;5282.735863206824;816.8856360109589;825.1748251748252;859.776458120893;886.663068034143;893.8122994171297;3336.4661654135707;3450;3492.89521314361;3508.964910350915;3566.3045706087582;8950.910490895138;9218.400803947721;9638.325317227727;9673.661421850202;9683.273754468442;9239.584218710173;9546.61813527465;9549.331546791658;9571.904280957102;9590.376625519459;7017.263187365355;7058.517711280689;7209.423246140401;7233.782986510413;7247.565146091251;5079.238114282887;5242.370915490165;5250.711210883438;5277.894442111213;5334.413214546319;8402.41183117176;8560.828783424422;8834.160754728291;8863.689770857989;8875.334349923653;8545.2309292164;8585.656573737231;8708.956455217683;8896.466212027299;8899.866502002606;6408.743650253938;6569.37590928861;6580.243272023778;6581.210254769267;6583;7155.677994490156;7272.636368181676;7325.230850760593;7387.261273872569;7398.778036658909;4912.778924948458;6472.676366181766;6551.082848401133;6684.565503242274;6781.42357899584;6304.369563043659;6349.07938348946;6409.2949775525585;6437.581557198767;6485.6108633482145;5969.074793407029;6004.429579190145;6029.246344206974;6069.393060693896;6092.543059270661;4046.2312160690553;4057.634812866856;4095.91808163841;4117.526484454326;4346.67399944999;4419.845305414295;4485.708428952108;4520.706154099973;4579.38178345919;4734.124187025412 08:32:27 INFO - PROCESS | 9754 | |4;prototype.html;292.27078439293956;304.2818947284408;305.36027023386;307.1476652289895;307.20740489536996;4695.64782641302;4834.48606724503;4895.339129217555;4914.238293064572;4920.729359885205;4819.662623616339;4839.540243676854;4852.733099679516;4854.4174699036075;4860.8541743747655;3617.336025428306;3696.907577310575;3714.349988751971;3816.790076545789;3819.9618003820024;3798.810059497028;3801.8594421673524;3810.3522401191726;3816.656500914917;3820.2550502651993;3775.263823554394;3778.1688028633794;3785.6782173515285;3790.715696322773;3801.2967600993766;3592.371335016388;3649.9817500912327;3762.1535154590274;3796.468494410785;3800.847966081353;3300.389427955836;3318.551995480603;3350.31318579693;3360.3447327771096;3365.3437579671972;4783.665143439961;4791.544803243686;4793.7363445010515;4807.42310922688;4813.422389313305;4051.918961620751;4365.650747940157;4377.212101821671;4390.363397307373;4391.912161756747;5012.72430016349;5048.697078175322;5060.746962651852;5124.5131712487255;5148.922766158511;3618.2220822523022;3619.855205791765;3628.2017956049626;3631.691306238973;3634.691051260646;5226.372835259793;5373.220882971987;5380.058489764276;5385.892282154335;5386.946130538723;3689.815509224528;3734.1971476132762;3737.4020156774786;3743.73793834429;3767.208886133888;3793.6206379361843;3793.81030948457;3796.981015094962;3809.8285577149095;3823.3691440912494;4350.434443522322;4354.390385346054;4355.346697995263;4364.738115713004;4367.75977321244;4972.801087956514;5082.567981721595;5117.309163262912;5117.769700363493;5120.769565369567;1296.6758310422395;1316.795896636023;1318.3671837518045;1319.511780641169;1320.5312114199512;819.5164852736914;839.9076101628816;847.4830353484369;852.5907564369138;855.8587833007608;4105.52201207565;4324.935125973113;4422.778861056934;4521.638268938477;4535.705179163344;5262.394824595144;5264.236685680555;5280.630355875129;5284.207368894697;5286.60350473716;4491.371208030879;4497.392851965008;4504.234280172313;4504.954950450519;4517.367568540407;2660.627512148301;2771.847548384818;2799.6220510231265;2804.467151241258;2823.7035111313426;4962.305277261186;4962.751862406865;4973.905740737032;4994.625403094782;5006.6495345325475;5279.815206467755;5422.8373148805595;5424.430434804368;5441.72119551905;5465;4894.681845680019;4921.975390123026;4953.18272485036;4957.925631115609;4960.189530821224;5278.736063196901;5285.365756109291;5290.523852853262;5298.6290959634;5313.309269794902;5047.848564543069;5162.483751624807;5178.404483484447;5181.17101263811;5196.350456192976;4904.509549045067;4937.703737775745;4946.431160416598;4947.3321101652255;4950.628702847373;3656.9817150914073;3674.853005879735;3684.834182461742;3696.1498855262903;3704.1665625234104;5056.949430505648;5293.285406470077;5295.523402893758;5300.7879684813715;5318.521333080042;5045.621578381562;5046.1673823818655;5051;5114.33513643224;5121.975604879113;5026;5058.861756104847;5088.211327244283;5122.848403670542;5124.590032797441;4796.496367881322;4977.601791856715;5004.124278251219;5011.523905228997;5021.794769255425;4894.755262236945;4971.676841005323;5073.18828987375;5102.336696229467;5120.820771272987;5006.07387633289;5012.949870501394;5014.373203349582;5027.095122877917;5032.924506132485 08:32:27 INFO - PROCESS | 9754 | |5;yui.html;580.8547863034241;612.6722203621064;660.4551245222692;662.6123717625189;668.1892072483568;11470.827937580932;11956.103292253094;12380.257184568909;12394.876051239497;12427.06796990226;12566.183198092118;12641.241525508476;12653.936730316358;12694.3652817359;12703.047271454654;612.7548980407851;743.460990781683;763.9503432276912;766.2146300042473;767.2710924621604;732.4726197138078;776.2509178642608;778.7546922719354;782.084960596101;782.659543098751;799.3724925933144;801.9278264956152;801.9879701804477;802.4262652203673;802.9357651387875;637.1621317966905;796.4584082823677;796.5260669901458;798.1898373151256;798.3852433626105;558.9105743081128;587.9382664820175;588.5556404914263;589.631480324797;590.6426611899825;11523.711907202303;11542.480588373543;11545.595904143314;11549.595764148215;11554.364509951949;11792.705182370424;12208.529479375946;12348.99863563486;12512.436940337706;12608.873911260862;11144.944275278653;11382;11457.484413201426;11571.884281157249;11665.358405287705;4047.1096358801015;4054.0878302382025;4073.409355643415;4112.383142528614;4126.236646220459;51662.22506662403;53283.20075198875;53676.87493126178;61233.69383153056;61881.69059154675;9986.450745209084;10248.538815753309;10315.638952636622;10339.844902326471;10412.68761937143;18290.17694203764;18339.449816505527;18344.449666510027;18425.631487370178;18430.354937577387;6664.500162487833;6751.291114433012;6751.898721519181;6826.761063362857;6908.274631163656;3578.9105272368397;3629.4374371972385;3640.3811352069683;3772.5472943246436;3795.7532760370486;2690.381212321138;2793.0922450203766;2802.1873656639345;2803.1310293808983;2806.396624725653;488.1116368209824;495.63075508746215;499.91501444754476;503.60215429810773;510.1404134034164;508.7557972173378;514.6063261604876;520.4041372628319;525.9192359700775;529.8595872093898;7708.807279817937;8207.138250483733;8331.95834020838;8365.916340836635;8833.867491987625;411.5555200383578;498.4093848789124;505.4616833072766;519.462356461061;526.0531044120568;3668.7437226106285;3819.866304679323;4037.1723796621623;4087.6321131098343;4181.832726690959;97542;98970;99000;100753.49623251837;102095;85152.57423712965;85634;85815;86258;86422.13577864267;74552;75695.62152189204;76338;77639.61180194176;78112.21887781049;7618.4667073306555;7633.961830190813;7664.693412263447;7688.884666730115;8097.2712455879255;35795;44118.33822492729;44731.97412232915;45521;47986.28020579764;37912.43131352977;44778.10443791171;57660.42339576718;60496.39503605084;62130;9066.68533062689;9269.814603707753;9534.427934323963;11801.704957376134;12219.69450763738;10141.695749127539;10528.894711052792;12787.424565894371;13142.802857956947;13809.723805523632;10752.784944300915;10848.511816968097;11379.54481820751;11652.126090543412;11710.824337635113;11235.49440275206;11756.529738810352;11998.580049698568;12331.136820422484;12340.197887137307;10914.181436392144;11142.888571114185;11229.831552526555;11690.824637630612;11721.4807753415;8950;9354.859677104712;9392;9405.153536181777;9431.669891553762;8439.282660973886;8551.1092452935;8640.222379985831;8972.48061823008;9299.581518831534 08:32:27 INFO - PROCESS | 9754 | __end_tp_report 08:32:27 INFO - PROCESS | 9754 | __start_cc_report 08:32:27 INFO - PROCESS | 9754 | _x_x_mozilla_cycle_collect,1052 08:32:27 INFO - PROCESS | 9754 | __end_cc_report 08:32:27 INFO - PROCESS | 9754 | __startTimestamp1471966347473__endTimestamp 08:32:27 INFO - PROCESS | 9754 | 08:32:27 INFO - PROCESS | 9754 | ------- Summary: start ------- 08:32:27 INFO - PROCESS | 9754 | Number of tests: 6 08:32:27 INFO - PROCESS | 9754 | 08:32:27 INFO - PROCESS | 9754 | [#0] dojo.html Cycles:165 Average:4661.96 Median:4764.57 stddev:489.03 (10.3%) stddev-sans-first:462.42 08:32:27 INFO - PROCESS | 9754 | Values: 2578.7 2605.8 2619.8 2619.8 2633.5 4579.2 4643.6 4702.8 4742.3 4743.3 4653.4 4724.7 4750.0 4813.4 4852.0 4142.9 4358.1 4426.7 4441.7 4442.0 4398.3 4422.3 4439.1 4446.6 4472.4 4214.9 4246.8 4274.9 4350.5 4357.8 4256.2 4256.6 4264.2 4279.8 4331.0 4271.1 4277.8 4289.6 4330.7 4348.0 4727.7 4740.3 4740.7 4741.5 4747.0 4899.8 4969.7 4975.9 5024.4 5116.4 5103.9 5109.5 5114.3 5128.6 5141.2 4596.2 4764.6 4776.3 4789.6 4797.1 5109.8 5111.9 5166.6 5197.2 5267.0 5040.5 5041.7 5043.1 5046.0 5047.5 4941.5 5108.1 5112.7 5118.8 5122.5 4922.2 4938.3 4991.6 5087.1 5091.3 5039.1 5041.2 5047.3 5058.5 5063.1 4200.7 4367.5 4380.5 4384.6 4391.6 3696.6 3745.0 3763.5 3784.2 3832.9 4319.6 4342.9 4345.1 4350.6 4351.0 4869.8 5073.9 5076.6 5082.8 5085.2 4288.5 4327.8 4333.6 4378.9 4388.2 4582.7 4598.4 4601.3 4615.4 4615.9 4572.2 4758.6 4767.2 4770.4 4775.0 4925.8 4975.9 4991.3 5038.5 5057.1 4738.8 4745.2 4745.5 4754.4 4759.5 4762.5 4965.6 4981.3 4987.9 4989.9 4928.0 4964.8 4969.8 5002.6 5017.7 4930.0 4934.0 4938.4 4939.7 4941.9 4711.8 4922.5 4945.9 4953.3 4957.0 4718.8 4739.7 4740.0 4800.0 4817.8 4912.9 4920.0 4934.3 4936.3 4952.0 4731.3 4829.8 4836.2 4846.4 4850.8 08:32:27 INFO - PROCESS | 9754 | 08:32:27 INFO - PROCESS | 9754 | [#1] ext.html Cycles:180 Average:44345.93 Median:18409.72 stddev:78568.06 (426.8%) stddev-sans-first:78719.66 08:32:27 INFO - PROCESS | 9754 | Values: 552.4 559.0 567.5 568.4 572.4 29094.1 39819.4 41019.8 41101.4 44515.6 40003.0 40375.4 40375.6 40411.0 40472.2 7041.5 7691.2 7814.9 7862.9 7864.1 9815.1 10080.1 10109.6 10462.2 10477.3 10128.9 10224.8 10226.8 10233.1 10252.8 10072.4 10073.6 10108.7 10130.1 10130.9 9864.7 9895.8 9933.9 9938.4 9944.5 37348.6 37750.2 37792.8 37800.8 37801.2 2722.8 2826.1 2827.7 2870.6 3106.0 28003.3 29005.6 29752.4 29811.9 29815.6 3319.7 3356.4 3463.6 3465.6 3503.5 248997.0 250352.0 250829.0 251013.0 251030.0 30939.1 53918.7 54397.7 54530.7 54532.5 31381.0 33095.2 33095.3 33105.3 33266.7 12131.4 12315.8 12320.1 12322.4 12329.5 9104.5 9521.2 9650.2 9699.3 9753.7 7771.4 7779.8 7813.6 7825.7 7907.8 3060.5 3063.4 3070.8 3076.5 3105.1 855.8 907.5 929.8 984.9 1024.9 26965.0 27958.7 28093.3 28229.7 28690.7 957.2 964.9 1019.3 1024.0 1055.6 14863.8 14880.3 14986.8 15064.2 15105.9 354310.0 359549.0 360408.0 360455.0 361707.0 48819.8 49195.8 49288.8 49358.8 49483.3 1059.5 1066.9 1089.7 1141.8 1198.4 25550.6 29145.7 29791.4 29978.3 30011.7 35700.8 35928.5 36015.6 36018.8 36048.6 275121.0 276795.0 276808.0 277114.0 277131.0 24479.6 24749.5 25595.6 25636.6 26987.5 41127.6 41288.8 41496.4 41532.4 42436.4 35678.1 36035.0 36074.8 36098.8 36102.0 35852.0 36019.5 36080.3 36457.3 36543.6 35419.0 36229.3 36316.3 36687.0 36689.8 30451.8 32943.3 33152.0 33184.7 33463.0 24878.0 25169.9 25214.7 25660.6 25847.5 08:32:27 INFO - PROCESS | 9754 | 08:32:27 INFO - PROCESS | 9754 | [#2] jquery.html Cycles:180 Average:24150.66 Median:24345.57 stddev:64147.38 (263.5%) stddev-sans-first:64302.43 08:32:27 INFO - PROCESS | 9754 | Values: 345.7 361.5 362.9 364.2 388.2 12708.6 16021.4 16452.3 17925.6 18108.6 13781.7 13883.9 16423.2 16533.8 16560.5 4907.3 4941.9 5107.6 5134.3 5178.4 3697.2 5022.1 5104.1 5106.1 5677.7 5904.9 5970.6 5982.9 5989.3 5995.2 5866.6 5962.6 5977.3 6040.7 6042.8 5273.1 5276.3 5277.9 5278.1 5280.6 20371.3 20753.7 20980.0 21181.6 21302.4 1904.2 1937.5 2061.4 2079.9 2577.3 13177.7 13211.5 13393.2 13396.3 13959.4 1690.5 1711.1 1722.2 1733.7 1812.9 44237.0 66458.3 70650.6 70653.3 72888.6 9992.0 10166.6 10252.3 10254.3 11055.7 14166.5 14235.8 14258.5 14270.5 14287.0 6905.3 7202.9 7279.2 7323.5 7349.8 6616.0 6633.6 6674.2 6846.7 6871.2 4222.2 4234.0 4397.1 4454.1 4547.1 1706.8 1806.9 1834.4 1886.1 1893.3 703.8 804.9 818.7 847.3 879.3 16234.8 17316.7 17502.3 17569.1 17824.6 836.5 849.0 852.5 876.2 877.5 8973.2 9858.1 9902.2 9922.6 10054.0 382786.0 384654.0 385295.0 393686.0 399886.0 49019.3 51055.7 74864.6 83135.3 84759.0 923.3 943.5 946.4 953.7 958.9 15763.9 16010.8 16146.8 16335.3 16525.8 37897.6 38181.0 38272.6 38465.2 39242.2 51396.0 55091.2 55148.0 55601.0 56151.0 6504.8 6816.5 7313.6 7505.8 7509.2 10182.2 11263.7 11330.3 11367.9 11799.4 9393.7 9621.8 9642.3 9956.0 10232.0 10075.4 10289.3 10347.2 10472.8 10943.0 9235.2 9719.6 9868.5 10111.2 10130.5 7422.0 7434.4 7453.6 7630.4 7944.3 7666.6 9647.8 10256.6 10274.9 10471.4 08:32:27 INFO - PROCESS | 9754 | 08:32:27 INFO - PROCESS | 9754 | [#3] mootools.html Cycles:180 Average:5008.28 Median:5245.49 stddev:2825.93 (53.9%) stddev-sans-first:2820.55 08:32:27 INFO - PROCESS | 9754 | Values: 1358.8 1396.2 1451.6 1635.3 1663.5 6691.9 6946.1 7250.1 7800.1 7834.1 7382.8 7705.5 7706.7 7941.2 7951.7 2161.1 2181.9 2191.1 2194.8 2195.9 1869.1 2040.2 2098.6 2121.9 2167.6 2153.3 2184.5 2189.4 2189.7 2190.6 2066.2 2083.0 2112.7 2113.4 2113.8 2062.7 2068.7 2070.7 2082.7 2083.3 7757.6 7788.7 7815.7 7830.0 7848.9 4281.5 4427.6 4438.8 4442.5 4453.6 2846.1 2958.8 2999.1 3004.1 3012.4 909.2 937.8 956.7 973.1 976.4 10448.1 10476.6 10482.2 10501.3 10511.7 3633.2 3928.9 4042.1 4054.5 4058.0 9116.7 9126.2 9132.5 9132.8 9140.0 4420.8 4423.4 4425.2 4427.9 4444.5 3979.9 4012.6 4020.6 4028.1 4062.0 3526.6 3591.9 3639.1 3751.6 3762.4 1065.8 1124.6 1165.7 1180.7 1217.0 695.6 708.1 722.1 728.1 768.7 4963.3 5100.4 5213.7 5248.6 5282.7 816.9 825.2 859.8 886.7 893.8 3336.5 3450.0 3492.9 3509.0 3566.3 8950.9 9218.4 9638.3 9673.7 9683.3 9239.6 9546.6 9549.3 9571.9 9590.4 7017.3 7058.5 7209.4 7233.8 7247.6 5079.2 5242.4 5250.7 5277.9 5334.4 8402.4 8560.8 8834.2 8863.7 8875.3 8545.2 8585.7 8709.0 8896.5 8899.9 6408.7 6569.4 6580.2 6581.2 6583.0 7155.7 7272.6 7325.2 7387.3 7398.8 4912.8 6472.7 6551.1 6684.6 6781.4 6304.4 6349.1 6409.3 6437.6 6485.6 5969.1 6004.4 6029.2 6069.4 6092.5 4046.2 4057.6 4095.9 4117.5 4346.7 4419.8 4485.7 4520.7 4579.4 4734.1 08:32:27 INFO - PROCESS | 9754 | 08:32:27 INFO - PROCESS | 9754 | [#4] prototype.html Cycles:180 Average:4234.60 Median:4853.58 stddev:1235.26 (25.5%) stddev-sans-first:1202.76 08:32:27 INFO - PROCESS | 9754 | Values: 292.3 304.3 305.4 307.1 307.2 4695.6 4834.5 4895.3 4914.2 4920.7 4819.7 4839.5 4852.7 4854.4 4860.9 3617.3 3696.9 3714.3 3816.8 3820.0 3798.8 3801.9 3810.4 3816.7 3820.3 3775.3 3778.2 3785.7 3790.7 3801.3 3592.4 3650.0 3762.2 3796.5 3800.8 3300.4 3318.6 3350.3 3360.3 3365.3 4783.7 4791.5 4793.7 4807.4 4813.4 4051.9 4365.7 4377.2 4390.4 4391.9 5012.7 5048.7 5060.7 5124.5 5148.9 3618.2 3619.9 3628.2 3631.7 3634.7 5226.4 5373.2 5380.1 5385.9 5386.9 3689.8 3734.2 3737.4 3743.7 3767.2 3793.6 3793.8 3797.0 3809.8 3823.4 4350.4 4354.4 4355.3 4364.7 4367.8 4972.8 5082.6 5117.3 5117.8 5120.8 1296.7 1316.8 1318.4 1319.5 1320.5 819.5 839.9 847.5 852.6 855.9 4105.5 4324.9 4422.8 4521.6 4535.7 5262.4 5264.2 5280.6 5284.2 5286.6 4491.4 4497.4 4504.2 4505.0 4517.4 2660.6 2771.8 2799.6 2804.5 2823.7 4962.3 4962.8 4973.9 4994.6 5006.6 5279.8 5422.8 5424.4 5441.7 5465.0 4894.7 4922.0 4953.2 4957.9 4960.2 5278.7 5285.4 5290.5 5298.6 5313.3 5047.8 5162.5 5178.4 5181.2 5196.4 4904.5 4937.7 4946.4 4947.3 4950.6 3657.0 3674.9 3684.8 3696.1 3704.2 5056.9 5293.3 5295.5 5300.8 5318.5 5045.6 5046.2 5051.0 5114.3 5122.0 5026.0 5058.9 5088.2 5122.8 5124.6 4796.5 4977.6 5004.1 5011.5 5021.8 4894.8 4971.7 5073.2 5102.3 5120.8 5006.1 5012.9 5014.4 5027.1 5032.9 08:32:27 INFO - PROCESS | 9754 | 08:32:27 INFO - PROCESS | 9754 | [#5] yui.html Cycles:180 Average:17262.75 Median:504.53 stddev:25135.79 (4982.0%) stddev-sans-first:25175.10 08:32:27 INFO - PROCESS | 9754 | Values: 580.9 612.7 660.5 662.6 668.2 11470.8 11956.1 12380.3 12394.9 12427.1 12566.2 12641.2 12653.9 12694.4 12703.0 612.8 743.5 764.0 766.2 767.3 732.5 776.3 778.8 782.1 782.7 799.4 801.9 802.0 802.4 802.9 637.2 796.5 796.5 798.2 798.4 558.9 587.9 588.6 589.6 590.6 11523.7 11542.5 11545.6 11549.6 11554.4 11792.7 12208.5 12349.0 12512.4 12608.9 11144.9 11382.0 11457.5 11571.9 11665.4 4047.1 4054.1 4073.4 4112.4 4126.2 51662.2 53283.2 53676.9 61233.7 61881.7 9986.5 10248.5 10315.6 10339.8 10412.7 18290.2 18339.4 18344.4 18425.6 18430.4 6664.5 6751.3 6751.9 6826.8 6908.3 3578.9 3629.4 3640.4 3772.5 3795.8 2690.4 2793.1 2802.2 2803.1 2806.4 488.1 495.6 499.9 503.6 510.1 508.8 514.6 520.4 525.9 529.9 7708.8 8207.1 8332.0 8365.9 8833.9 411.6 498.4 505.5 519.5 526.1 3668.7 3819.9 4037.2 4087.6 4181.8 97542.0 98970.0 99000.0 100753.5 102095.0 85152.6 85634.0 85815.0 86258.0 86422.1 74552.0 75695.6 76338.0 77639.6 78112.2 7618.5 7634.0 7664.7 7688.9 8097.3 35795.0 44118.3 44732.0 45521.0 47986.3 37912.4 44778.1 57660.4 60496.4 62130.0 9066.7 9269.8 9534.4 11801.7 12219.7 10141.7 10528.9 12787.4 13142.8 13809.7 10752.8 10848.5 11379.5 11652.1 11710.8 11235.5 11756.5 11998.6 12331.1 12340.2 10914.2 11142.9 11229.8 11690.8 11721.5 8950.0 9354.9 9392.0 9405.2 9431.7 8439.3 8551.1 8640.2 8972.5 9299.6 08:32:27 INFO - PROCESS | 9754 | -------- Summary: end -------- 08:32:27 INFO - PROCESS | 9754 | 08:32:28 INFO - TEST-INFO | 9754: exit 0 08:32:28 INFO - TEST-OK | dromaeo_css | took 1122249ms 08:32:28 INFO - TEST-START | kraken 08:32:28 INFO - operating with platform_type : linux_ 08:32:28 INFO - Initialising browser for kraken test... 08:32:28 INFO - TEST-INFO | started process 10060 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqKonLy/profile http://localhost:43454/getInfo.html) 08:32:32 INFO - PROCESS | 10060 | __metrics Screen width/height:1600/1200 08:32:32 INFO - PROCESS | 10060 | colorDepth:24 08:32:32 INFO - PROCESS | 10060 | Browser inner width/height: 1024/697 08:32:32 INFO - PROCESS | 10060 | __metrics 08:32:33 INFO - PROCESS | 10060 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:32:33 INFO - PROCESS | 10060 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:32:34 INFO - TEST-INFO | 10060: exit 0 08:32:34 INFO - Browser initialized. 08:32:34 INFO - Running cycle 1/1 for kraken test... 08:32:34 INFO - TEST-INFO | started process 10138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqKonLy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:32:46 INFO - PROCESS | 10138 | RSS: Main: 176259072 08:32:46 INFO - PROCESS | 10138 | 08:32:49 INFO - PROCESS | 10138 | Cycle 1(1): loaded http://localhost:43454/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43454/tests/kraken/driver.html?testName=audio-beat-detection) 08:32:50 INFO - PROCESS | 10138 | RSS: Main: 235974656 08:32:50 INFO - PROCESS | 10138 | 08:32:53 INFO - PROCESS | 10138 | Cycle 1(1): loaded http://localhost:43454/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43454/tests/kraken/driver.html?testName=audio-dft) 08:32:53 INFO - PROCESS | 10138 | RSS: Main: 226930688 08:32:53 INFO - PROCESS | 10138 | 08:32:57 INFO - PROCESS | 10138 | Cycle 1(1): loaded http://localhost:43454/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43454/tests/kraken/driver.html?testName=audio-fft) 08:32:57 INFO - PROCESS | 10138 | RSS: Main: 302977024 08:32:57 INFO - PROCESS | 10138 | 08:32:59 INFO - PROCESS | 10138 | Cycle 1(1): loaded http://localhost:43454/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43454/tests/kraken/driver.html?testName=audio-oscillator) 08:33:00 INFO - PROCESS | 10138 | RSS: Main: 210018304 08:33:00 INFO - PROCESS | 10138 | 08:33:02 INFO - PROCESS | 10138 | Cycle 1(1): loaded http://localhost:43454/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43454/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:33:03 INFO - PROCESS | 10138 | RSS: Main: 214183936 08:33:03 INFO - PROCESS | 10138 | 08:33:06 INFO - PROCESS | 10138 | Cycle 1(1): loaded http://localhost:43454/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43454/tests/kraken/driver.html?testName=imaging-darkroom) 08:33:07 INFO - PROCESS | 10138 | RSS: Main: 251023360 08:33:07 INFO - PROCESS | 10138 | 08:33:10 INFO - PROCESS | 10138 | Cycle 1(1): loaded http://localhost:43454/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43454/tests/kraken/driver.html?testName=imaging-desaturate) 08:33:11 INFO - PROCESS | 10138 | RSS: Main: 244781056 08:33:11 INFO - PROCESS | 10138 | 08:33:14 INFO - PROCESS | 10138 | Cycle 1(1): loaded http://localhost:43454/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43454/tests/kraken/driver.html?testName=json-parse-financial) 08:33:14 INFO - PROCESS | 10138 | RSS: Main: 247816192 08:33:14 INFO - PROCESS | 10138 | 08:33:16 INFO - PROCESS | 10138 | Cycle 1(1): loaded http://localhost:43454/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43454/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:33:17 INFO - PROCESS | 10138 | RSS: Main: 212029440 08:33:17 INFO - PROCESS | 10138 | 08:33:19 INFO - PROCESS | 10138 | Cycle 1(1): loaded http://localhost:43454/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43454/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:33:19 INFO - PROCESS | 10138 | RSS: Main: 218468352 08:33:19 INFO - PROCESS | 10138 | 08:33:22 INFO - PROCESS | 10138 | Cycle 1(1): loaded http://localhost:43454/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43454/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:33:22 INFO - PROCESS | 10138 | RSS: Main: 222552064 08:33:22 INFO - PROCESS | 10138 | 08:33:25 INFO - PROCESS | 10138 | Cycle 1(1): loaded http://localhost:43454/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43454/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:33:26 INFO - PROCESS | 10138 | RSS: Main: 219054080 08:33:26 INFO - PROCESS | 10138 | 08:33:29 INFO - PROCESS | 10138 | Cycle 1(1): loaded http://localhost:43454/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43454/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:33:29 INFO - PROCESS | 10138 | RSS: Main: 222150656 08:33:29 INFO - PROCESS | 10138 | 08:33:31 INFO - PROCESS | 10138 | Cycle 1(1): loaded http://localhost:43454/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43454/tests/kraken/driver.html?testName=ai-astar) 08:33:31 INFO - PROCESS | 10138 | RSS: Main: 273104896 08:33:31 INFO - PROCESS | 10138 | 08:33:31 INFO - PROCESS | 10138 | __start_tp_report 08:33:31 INFO - PROCESS | 10138 | _x_x_mozilla_page_load 08:33:31 INFO - PROCESS | 10138 | _x_x_mozilla_page_load_details 08:33:31 INFO - PROCESS | 10138 | |i|pagename|runs| 08:33:31 INFO - PROCESS | 10138 | |0;ai-astar;102;114;113;115;113;114;119;113;113;115 08:33:31 INFO - PROCESS | 10138 | |1;audio-beat-detection;162;129;149;196;125;149;153;141;200;120 08:33:31 INFO - PROCESS | 10138 | |2;audio-dft;163;162;162;163;161;164;163;161;162;163 08:33:31 INFO - PROCESS | 10138 | |3;audio-fft;75;77;76;168;76;75;76;77;158;77 08:33:31 INFO - PROCESS | 10138 | |4;audio-oscillator;91;87;146;88;87;88;139;86;87;143 08:33:31 INFO - PROCESS | 10138 | |5;imaging-gaussian-blur;116;117;117;117;116;117;117;116;117;117 08:33:31 INFO - PROCESS | 10138 | |6;imaging-darkroom;146;146;146;146;146;146;146;147;146;146 08:33:31 INFO - PROCESS | 10138 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;96 08:33:31 INFO - PROCESS | 10138 | |8;json-parse-financial;63;64;65;64;64;65;66;64;64;65 08:33:31 INFO - PROCESS | 10138 | |9;json-stringify-tinderbox;68;68;66;67;66;66;67;72;66;67 08:33:31 INFO - PROCESS | 10138 | |10;stanford-crypto-aes;83;82;86;83;87;82;83;84;85;84 08:33:31 INFO - PROCESS | 10138 | |11;stanford-crypto-ccm;133;136;130;141;143;139;134;133;155;134 08:33:31 INFO - PROCESS | 10138 | |12;stanford-crypto-pbkdf2;177;171;170;168;174;172;172;172;172;175 08:33:31 INFO - PROCESS | 10138 | |13;stanford-crypto-sha256-iterative;71;69;68;70;69;69;69;68;67;72 08:33:31 INFO - PROCESS | 10138 | __end_tp_report 08:33:31 INFO - PROCESS | 10138 | __start_cc_report 08:33:31 INFO - PROCESS | 10138 | _x_x_mozilla_cycle_collect,2013 08:33:31 INFO - PROCESS | 10138 | __end_cc_report 08:33:31 INFO - PROCESS | 10138 | __startTimestamp1471966411776__endTimestamp 08:33:31 INFO - PROCESS | 10138 | 08:33:31 INFO - PROCESS | 10138 | ------- Summary: start ------- 08:33:31 INFO - PROCESS | 10138 | Number of tests: 14 08:33:31 INFO - PROCESS | 10138 | 08:33:31 INFO - PROCESS | 10138 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:4.31 (3.8%) stddev-sans-first:1.94 08:33:31 INFO - PROCESS | 10138 | Values: 102.0 114.0 113.0 115.0 113.0 114.0 119.0 113.0 113.0 115.0 08:33:31 INFO - PROCESS | 10138 | 08:33:31 INFO - PROCESS | 10138 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:151.00 stddev:27.41 (18.2%) stddev-sans-first:28.85 08:33:31 INFO - PROCESS | 10138 | Values: 162.0 129.0 149.0 196.0 125.0 149.0 153.0 141.0 200.0 120.0 08:33:31 INFO - PROCESS | 10138 | 08:33:31 INFO - PROCESS | 10138 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 08:33:31 INFO - PROCESS | 10138 | Values: 163.0 162.0 162.0 163.0 161.0 164.0 163.0 161.0 162.0 163.0 08:33:31 INFO - PROCESS | 10138 | 08:33:31 INFO - PROCESS | 10138 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.00 stddev:36.71 (48.3%) stddev-sans-first:38.32 08:33:31 INFO - PROCESS | 10138 | Values: 75.0 77.0 76.0 168.0 76.0 75.0 76.0 77.0 158.0 77.0 08:33:31 INFO - PROCESS | 10138 | 08:33:31 INFO - PROCESS | 10138 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:87.00 stddev:26.63 (30.6%) stddev-sans-first:27.81 08:33:31 INFO - PROCESS | 10138 | Values: 91.0 87.0 146.0 88.0 87.0 88.0 139.0 86.0 87.0 143.0 08:33:31 INFO - PROCESS | 10138 | 08:33:31 INFO - PROCESS | 10138 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 08:33:31 INFO - PROCESS | 10138 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 08:33:31 INFO - PROCESS | 10138 | 08:33:31 INFO - PROCESS | 10138 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 08:33:31 INFO - PROCESS | 10138 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 08:33:31 INFO - PROCESS | 10138 | 08:33:31 INFO - PROCESS | 10138 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:33:31 INFO - PROCESS | 10138 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 08:33:31 INFO - PROCESS | 10138 | 08:33:31 INFO - PROCESS | 10138 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.50 stddev:0.84 (1.3%) stddev-sans-first:0.73 08:33:31 INFO - PROCESS | 10138 | Values: 63.0 64.0 65.0 64.0 64.0 65.0 66.0 64.0 64.0 65.0 08:33:31 INFO - PROCESS | 10138 | 08:33:31 INFO - PROCESS | 10138 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:1.83 (2.7%) stddev-sans-first:1.92 08:33:31 INFO - PROCESS | 10138 | Values: 68.0 68.0 66.0 67.0 66.0 66.0 67.0 72.0 66.0 67.0 08:33:31 INFO - PROCESS | 10138 | 08:33:31 INFO - PROCESS | 10138 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:1.66 (2.0%) stddev-sans-first:1.73 08:33:31 INFO - PROCESS | 10138 | Values: 83.0 82.0 86.0 83.0 87.0 82.0 83.0 84.0 85.0 84.0 08:33:31 INFO - PROCESS | 10138 | 08:33:31 INFO - PROCESS | 10138 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:137.50 stddev:7.25 (5.3%) stddev-sans-first:7.48 08:33:31 INFO - PROCESS | 10138 | Values: 133.0 136.0 130.0 141.0 143.0 139.0 134.0 133.0 155.0 134.0 08:33:31 INFO - PROCESS | 10138 | 08:33:31 INFO - PROCESS | 10138 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:172.00 stddev:2.54 (1.5%) stddev-sans-first:2.05 08:33:31 INFO - PROCESS | 10138 | Values: 177.0 171.0 170.0 168.0 174.0 172.0 172.0 172.0 172.0 175.0 08:33:31 INFO - PROCESS | 10138 | 08:33:31 INFO - PROCESS | 10138 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:1.48 (2.1%) stddev-sans-first:1.41 08:33:31 INFO - PROCESS | 10138 | Values: 71.0 69.0 68.0 70.0 69.0 69.0 69.0 68.0 67.0 72.0 08:33:31 INFO - PROCESS | 10138 | -------- Summary: end -------- 08:33:31 INFO - PROCESS | 10138 | 08:33:33 INFO - TEST-INFO | 10138: exit 0 08:33:33 INFO - TEST-OK | kraken | took 64797ms 08:33:33 INFO - SUITE-END | took 1187s 08:33:33 INFO - Completed test suite (00:19:47) 08:33:33 INFO - javascript benchmark 08:33:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2578.6647735794345, 2605.7654811067, 2619.777318927891, 2619.816612837101, 2633.525965326242, 4579.198640237953, 4643.605293550048, 4702.8118875244945, 4742.288656701497, 4743.288506723989, 4653.3717948077, 4724.692894961825, 4750.026244619853, 4813.350197723306, 4851.975740121304, 4142.855000074998, 4358.0848021915435, 4426.712263702865, 4441.711288766236, 4442.0, 4398.340248962665, 4422.270325396305, 4439.089986552749, 4446.622037126848, 4472.44094488189, 4214.936775948363, 4246.766427846467, 4274.850380236708, 4350.499692535367, 4357.84747533838, 4256.2338779019765, 4256.616904478581, 4264.23243816113, 4279.786010699452, 4330.956690433087, 4271.145770845812, 4277.786110694453, 4289.592488713599, 4330.675199360029, 4348.0, 4727.739974301412, 4740.265258884879, 4740.715557066587, 4741.549552792514, 4747.0, 4899.755012249373, 4969.652124351297, 4975.875603109915, 5024.371953505812, 5116.386033675945, 5103.897922041576, 5109.489051094898, 5114.335136432277, 5128.589712822965, 5141.228815677641, 4596.17268891596, 4764.571188593043, 4776.331313616097, 4789.568938795525, 4797.136515427187, 5109.846704598868, 5111.948880511221, 5166.61250406221, 5197.194434862602, 5267.0256002639635, 5040.521150490697, 5041.697498150123, 5043.0922433961505, 5046.0, 5047.545720885138, 4941.530554597308, 5108.106081435808, 5112.744362781846, 5118.769655365518, 5122.513361230677, 4922.187839006596, 4938.283948827472, 4991.550760431579, 5087.084324821493, 5091.287219789232, 5039.092963266574, 5041.218611115283, 5047.293378926953, 5058.494150584986, 5063.11395505785, 4200.726952748061, 4367.475902891673, 4380.540043295472, 4384.583464570861, 4391.604755572014, 3696.6488183622514, 3744.9812750936617, 3763.5295588051495, 3784.2053168834304, 3832.865849695303, 4319.632831209319, 4342.934855977162, 4345.109252603209, 4350.564943505624, 4351.042770590465, 4869.780859861315, 5073.923891141636, 5076.6192535559985, 5082.822101226439, 5085.160948443466, 4288.48538175421, 4327.82688692455, 4333.609975102193, 4378.912421751611, 4388.188185185751, 4582.747948862778, 4598.448186217675, 4601.263797792337, 4615.353850460938, 4615.9076818463445, 4572.222722137178, 4758.595519380891, 4767.237242041257, 4770.356001939694, 4775.044991001883, 4925.827596034122, 4975.875603109951, 4991.276264941635, 5038.496150384932, 5057.14028615129, 4738.810447582058, 4745.217039188496, 4745.549172828576, 4754.381930349171, 4759.476457589732, 4762.476127626028, 4965.627577931742, 4981.3026176334615, 4987.875303117451, 4989.925151122663, 4927.975360123177, 4964.826231081895, 4969.776360063878, 5002.624803139852, 5017.749112544285, 4929.950700492949, 4934.0, 4938.43208031081, 4939.7036177828, 4941.851744447672, 4711.78796954131, 4922.483139270468, 4945.901081978413, 4953.331300274417, 4957.03337849116, 4718.787654555485, 4739.668223224479, 4739.976300118616, 4800.039992001543, 4817.759112044454, 4912.852614421573, 4919.950800491949, 4934.259861020875, 4936.3089167515855, 4951.9752401237765, 4731.337612734151, 4829.830955916526, 4836.202026665702, 4846.36997190363, 4850.7817148227705], "value": 4630.5975922171065, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.4420335461184, 558.983230503085, 567.5176100314732, 568.428729127227, 572.3818276261638, 29094.127176184695, 39819.40270895935, 41019.79490102545, 41101.38347924784, 44515.554844451544, 40003.0, 40375.39436908449, 40375.59624403755, 40411.0, 40472.190556188856, 7041.507094503387, 7691.1924247954, 7814.882776758353, 7862.921370786276, 7864.05631324239, 9815.116639502443, 10080.09279164875, 10109.59561617538, 10462.163026957825, 10477.26659133861, 10128.949355253213, 10224.795504089914, 10226.846597301046, 10233.130183934374, 10252.794944101113, 10072.446015469182, 10073.647422340257, 10108.696739097766, 10130.138938190263, 10130.949345253264, 9864.704058878246, 9895.802083958353, 9933.850992235122, 9938.403695778277, 9944.45305508204, 37348.62651373479, 37750.24499509994, 37792.81103594492, 37800.81099594484, 37801.24397512034, 2722.8366298022183, 2826.109775420736, 2827.7172282771558, 2870.626818513601, 3106.0060780550234, 28003.289227778983, 29005.608874485853, 29752.40495190084, 29811.850940745375, 29815.552766708515, 3319.6514365991707, 3356.4461863792444, 3463.6363181865795, 3465.6187819339852, 3503.4774962027554, 248997.0, 250352.0, 250829.0, 251013.0, 251030.0, 30939.0718278452, 53918.65203369869, 54397.72801135969, 54530.72734636301, 54532.45467545353, 31381.0, 33095.18690911299, 33095.33809323848, 33105.337893242, 33266.66733332684, 12131.393430328448, 12315.815262771066, 12320.137590368768, 12322.383880805924, 12329.50681972729, 9104.544772761335, 9521.23830093591, 9650.227981761442, 9699.272554558294, 9753.658621948198, 7771.417143714131, 7779.844403111906, 7813.621135869852, 7825.686972521035, 7907.802304942307, 3060.540918862144, 3063.387322535502, 3070.815751054944, 3076.461619216628, 3105.0995211388895, 855.7603870916154, 907.4963395315663, 929.8330595103102, 984.9359791613665, 1024.9231307651955, 26965.001722700414, 27958.720412796018, 28093.297667558065, 28229.71770282312, 28690.713092868806, 957.2294303085944, 964.8986856379979, 1019.2559431614962, 1023.9692809215586, 1055.6094245129198, 14863.777043344358, 14880.330385132478, 14986.775198372034, 15064.171470569225, 15105.924470377578, 354310.0, 359549.0, 360408.0, 360455.0, 361707.0, 48819.75590122027, 49195.754021229666, 49288.75355623199, 49358.753206234454, 49483.288753343644, 1059.5496913811598, 1066.9466526673634, 1089.743910181091, 1141.7944769941491, 1198.4487135917402, 25550.616740748534, 29145.688444019645, 29791.404171916005, 29978.25054373658, 30011.69988300089, 35700.821495892356, 35928.4610730834, 36015.63984360123, 36018.8199059003, 36048.63951360558, 275121.0, 276795.0, 276808.0, 277114.0, 277131.0, 24479.632805507576, 24749.505009900062, 25595.6160657594, 25636.61545076788, 26987.46025079448, 41127.58872411357, 41288.793556032026, 41496.37755433731, 41532.37701434542, 42436.36345454759, 35678.10804729799, 36035.0, 36074.819625901706, 36098.819505902306, 36102.0, 35852.0, 36019.45970810492, 36080.27839443249, 36457.27085458223, 36543.63456365402, 35419.0, 36229.27541449209, 36316.27367452583, 36687.0, 36689.79861208229, 30451.847740761154, 32943.34113317672, 33152.0, 33184.66815331912, 33463.0, 24878.0, 25169.87415062913, 25214.74785252124, 25660.615090774027, 25847.483050338513], "value": 16591.551483155843, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.7147853021255, 361.472250514249, 362.87480819117405, 364.17150981517045, 388.1635076410335, 12708.555200567971, 16021.439249626266, 16452.25964831581, 17925.551861203476, 18108.63782724345, 13781.655458613539, 13883.861161388382, 16423.178841057957, 16533.83466165341, 16560.503184904443, 4907.288443175728, 4941.901161976758, 5107.642465027431, 5134.332536770234, 5178.446466060186, 3697.1866189438415, 5022.146235140035, 5104.081265372231, 5106.131957567222, 5677.659340439587, 5904.911426328608, 5970.582059255854, 5982.8504287392725, 5989.251343582052, 5995.160677505131, 5866.592017915691, 5962.5528085393335, 5977.342492325841, 6040.728167232485, 6042.848928776772, 5273.077211488013, 5276.287701160332, 5277.894442111175, 5278.10272253714, 5280.603954703374, 20371.287004954756, 20753.688694669592, 20980.0, 21181.5763684727, 21302.36092917215, 1904.190718944443, 1937.4962509747568, 2061.4331058958905, 2079.9376018719463, 2577.2965677396387, 13177.670558236025, 13211.471541138439, 13393.19640821544, 13396.263205523692, 13959.417507760994, 1690.484402257311, 1711.0674682298177, 1722.1991773825107, 1733.7139372003605, 1812.8730988830787, 44237.0, 66458.3354166457, 70650.64674676645, 70653.2934670657, 72888.63555682241, 9991.950040249752, 10166.593336266615, 10252.333598316085, 10254.333468324536, 11055.72360690989, 14166.504172353918, 14235.78646320306, 14258.500952466615, 14270.500532481521, 14286.999910006407, 6905.274946130685, 7202.855942881113, 7279.235680253603, 7323.523970941872, 7349.77950661481, 6615.966920165464, 6633.568818026813, 6674.16572928384, 6846.691898864563, 6871.244163142051, 4222.239996800606, 4234.0, 4397.0985947881245, 4454.131444368382, 4547.113312904018, 1706.7781188445672, 1806.900620465887, 1834.4038187589088, 1886.0946745562208, 1893.2616279650672, 703.8134894253027, 804.9154838741965, 818.6970820796344, 847.2967437027253, 879.2877769006997, 16234.837651623333, 17316.65366692659, 17502.299908003537, 17569.121543922753, 17824.643507130044, 836.5022811427191, 848.9660413583388, 852.5140669818268, 876.1763941894599, 877.5392918717724, 8973.192412682889, 9858.112769850748, 9902.207823374112, 9922.553485093189, 10054.0, 382786.0, 384654.0, 385295.0, 393686.0, 399886.0, 49019.26471102936, 51055.744721276154, 74864.62567687235, 83135.33729325501, 84759.0, 923.3351986569659, 943.5188054092463, 946.3801210207188, 953.7043516509904, 958.9328746987784, 15763.921180394025, 16010.759838602196, 16146.757798632794, 16335.346586136422, 16525.83474165243, 37897.62102379051, 38181.0, 38272.61727382691, 38465.2306953865, 39242.215155696154, 51396.0, 55091.17363239635, 55148.0, 55601.0, 56151.0, 6504.772332968323, 6816.522843400914, 7313.597752123685, 7505.849883002418, 7509.17399086111, 10182.185425166117, 11263.66209013731, 11330.320180789178, 11367.896939065968, 11799.410029498318, 9393.671221507215, 9621.759456013375, 9642.276829237695, 9956.0, 10232.02795734404, 10075.445850478294, 10289.250827359218, 10347.223958203014, 10472.790544189225, 10943.0, 9235.1688348049, 9719.562619682272, 9868.506574671093, 10111.191104711459, 10130.544125514221, 7422.0, 7434.442416818868, 7453.552786832807, 7630.389568834591, 7944.285014348737, 7666.6166691664075, 9647.807043859224, 10256.641017564349, 10274.897251027693, 10471.42407167613], "value": 8245.199302414123, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.8233529641143, 1396.225095072235, 1451.6008097773117, 1635.2641311409868, 1663.5342104210824, 6691.933080669191, 6946.062281591983, 7250.093738282715, 7800.141984381714, 7834.05991281047, 7382.7785166444955, 7705.460617756759, 7706.653200605972, 7941.245581669732, 7951.72168974086, 2161.146347192858, 2181.923632672857, 2191.1345018717598, 2194.8024677779, 2195.9341219763432, 1869.0654672663668, 2040.1839264294254, 2098.6117568249847, 2121.9363419097454, 2167.5881582499355, 2153.3001774423296, 2184.541246338271, 2189.397915573214, 2189.6934429179846, 2190.6385446401405, 2066.2148383614203, 2082.9895850520725, 2112.6830975353664, 2113.38711773587, 2113.778053304396, 2062.6596611559075, 2068.6690129579197, 2070.7411573553304, 2082.739657542807, 2083.270855200683, 7757.5733334666575, 7788.6884524618945, 7815.687372505093, 7830.0, 7848.882266766003, 4281.48622165339, 4427.557244275579, 4438.778061096965, 4442.466903971512, 4453.643708503312, 2846.131929761422, 2958.8076775009554, 2999.100269919016, 3004.1137864330076, 3012.412579546989, 909.2407839454064, 937.8265020971143, 956.7321150077989, 973.0998826085913, 976.3604838830578, 10448.111910487542, 10476.58093676252, 10482.213833962483, 10501.264911456201, 10511.684649460529, 3633.237020225782, 3928.8821335359985, 4042.0501182222156, 4054.533728621246, 4057.9797101014306, 9116.680916168036, 9126.224270937044, 9132.452052876848, 9132.771680708036, 9140.040295768982, 4420.823167073346, 4423.358613001097, 4425.247707889666, 4427.867163985085, 4444.511103778646, 3979.8806035818393, 4012.6388625023887, 4020.577839326829, 4028.133951200506, 4062.045419326456, 3526.594441639193, 3591.9102022449647, 3639.1448009717697, 3751.6248375162268, 3762.435634654824, 1065.7655315830505, 1124.578283143821, 1165.7143999719954, 1180.7461395799944, 1217.0324591949422, 695.6452209373256, 708.1431467923767, 722.1262272650047, 728.1480667618898, 768.7040489411505, 4963.305137280783, 5100.438951715309, 5213.739313034409, 5248.606354523426, 5282.735863206824, 816.8856360109589, 825.1748251748252, 859.776458120893, 886.663068034143, 893.8122994171297, 3336.4661654135707, 3450.0, 3492.89521314361, 3508.964910350915, 3566.3045706087582, 8950.910490895138, 9218.400803947721, 9638.325317227727, 9673.661421850202, 9683.273754468442, 9239.584218710173, 9546.61813527465, 9549.331546791658, 9571.904280957102, 9590.376625519459, 7017.263187365355, 7058.517711280689, 7209.423246140401, 7233.782986510413, 7247.565146091251, 5079.238114282887, 5242.370915490165, 5250.711210883438, 5277.894442111213, 5334.413214546319, 8402.41183117176, 8560.828783424422, 8834.160754728291, 8863.689770857989, 8875.334349923653, 8545.2309292164, 8585.656573737231, 8708.956455217683, 8896.466212027299, 8899.866502002606, 6408.743650253938, 6569.37590928861, 6580.243272023778, 6581.210254769267, 6583.0, 7155.677994490156, 7272.636368181676, 7325.230850760593, 7387.261273872569, 7398.778036658909, 4912.778924948458, 6472.676366181766, 6551.082848401133, 6684.565503242274, 6781.42357899584, 6304.369563043659, 6349.07938348946, 6409.2949775525585, 6437.581557198767, 6485.6108633482145, 5969.074793407029, 6004.429579190145, 6029.246344206974, 6069.393060693896, 6092.543059270661, 4046.2312160690553, 4057.634812866856, 4095.91808163841, 4117.526484454326, 4346.67399944999, 4419.845305414295, 4485.708428952108, 4520.706154099973, 4579.38178345919, 4734.124187025412], "value": 4029.5857676468604, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.27078439293956, 304.2818947284408, 305.36027023386, 307.1476652289895, 307.20740489536996, 4695.64782641302, 4834.48606724503, 4895.339129217555, 4914.238293064572, 4920.729359885205, 4819.662623616339, 4839.540243676854, 4852.733099679516, 4854.4174699036075, 4860.8541743747655, 3617.336025428306, 3696.907577310575, 3714.349988751971, 3816.790076545789, 3819.9618003820024, 3798.810059497028, 3801.8594421673524, 3810.3522401191726, 3816.656500914917, 3820.2550502651993, 3775.263823554394, 3778.1688028633794, 3785.6782173515285, 3790.715696322773, 3801.2967600993766, 3592.371335016388, 3649.9817500912327, 3762.1535154590274, 3796.468494410785, 3800.847966081353, 3300.389427955836, 3318.551995480603, 3350.31318579693, 3360.3447327771096, 3365.3437579671972, 4783.665143439961, 4791.544803243686, 4793.7363445010515, 4807.42310922688, 4813.422389313305, 4051.918961620751, 4365.650747940157, 4377.212101821671, 4390.363397307373, 4391.912161756747, 5012.72430016349, 5048.697078175322, 5060.746962651852, 5124.5131712487255, 5148.922766158511, 3618.2220822523022, 3619.855205791765, 3628.2017956049626, 3631.691306238973, 3634.691051260646, 5226.372835259793, 5373.220882971987, 5380.058489764276, 5385.892282154335, 5386.946130538723, 3689.815509224528, 3734.1971476132762, 3737.4020156774786, 3743.73793834429, 3767.208886133888, 3793.6206379361843, 3793.81030948457, 3796.981015094962, 3809.8285577149095, 3823.3691440912494, 4350.434443522322, 4354.390385346054, 4355.346697995263, 4364.738115713004, 4367.75977321244, 4972.801087956514, 5082.567981721595, 5117.309163262912, 5117.769700363493, 5120.769565369567, 1296.6758310422395, 1316.795896636023, 1318.3671837518045, 1319.511780641169, 1320.5312114199512, 819.5164852736914, 839.9076101628816, 847.4830353484369, 852.5907564369138, 855.8587833007608, 4105.52201207565, 4324.935125973113, 4422.778861056934, 4521.638268938477, 4535.705179163344, 5262.394824595144, 5264.236685680555, 5280.630355875129, 5284.207368894697, 5286.60350473716, 4491.371208030879, 4497.392851965008, 4504.234280172313, 4504.954950450519, 4517.367568540407, 2660.627512148301, 2771.847548384818, 2799.6220510231265, 2804.467151241258, 2823.7035111313426, 4962.305277261186, 4962.751862406865, 4973.905740737032, 4994.625403094782, 5006.6495345325475, 5279.815206467755, 5422.8373148805595, 5424.430434804368, 5441.72119551905, 5465.0, 4894.681845680019, 4921.975390123026, 4953.18272485036, 4957.925631115609, 4960.189530821224, 5278.736063196901, 5285.365756109291, 5290.523852853262, 5298.6290959634, 5313.309269794902, 5047.848564543069, 5162.483751624807, 5178.404483484447, 5181.17101263811, 5196.350456192976, 4904.509549045067, 4937.703737775745, 4946.431160416598, 4947.3321101652255, 4950.628702847373, 3656.9817150914073, 3674.853005879735, 3684.834182461742, 3696.1498855262903, 3704.1665625234104, 5056.949430505648, 5293.285406470077, 5295.523402893758, 5300.7879684813715, 5318.521333080042, 5045.621578381562, 5046.1673823818655, 5051.0, 5114.33513643224, 5121.975604879113, 5026.0, 5058.861756104847, 5088.211327244283, 5122.848403670542, 5124.590032797441, 4796.496367881322, 4977.601791856715, 5004.124278251219, 5011.523905228997, 5021.794769255425, 4894.755262236945, 4971.676841005323, 5073.18828987375, 5102.336696229467, 5120.820771272987, 5006.07387633289, 5012.949870501394, 5014.373203349582, 5027.095122877917, 5032.924506132485], "value": 3841.420011516653, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.8547863034241, 612.6722203621064, 660.4551245222692, 662.6123717625189, 668.1892072483568, 11470.827937580932, 11956.103292253094, 12380.257184568909, 12394.876051239497, 12427.06796990226, 12566.183198092118, 12641.241525508476, 12653.936730316358, 12694.3652817359, 12703.047271454654, 612.7548980407851, 743.460990781683, 763.9503432276912, 766.2146300042473, 767.2710924621604, 732.4726197138078, 776.2509178642608, 778.7546922719354, 782.084960596101, 782.659543098751, 799.3724925933144, 801.9278264956152, 801.9879701804477, 802.4262652203673, 802.9357651387875, 637.1621317966905, 796.4584082823677, 796.5260669901458, 798.1898373151256, 798.3852433626105, 558.9105743081128, 587.9382664820175, 588.5556404914263, 589.631480324797, 590.6426611899825, 11523.711907202303, 11542.480588373543, 11545.595904143314, 11549.595764148215, 11554.364509951949, 11792.705182370424, 12208.529479375946, 12348.99863563486, 12512.436940337706, 12608.873911260862, 11144.944275278653, 11382.0, 11457.484413201426, 11571.884281157249, 11665.358405287705, 4047.1096358801015, 4054.0878302382025, 4073.409355643415, 4112.383142528614, 4126.236646220459, 51662.22506662403, 53283.20075198875, 53676.87493126178, 61233.69383153056, 61881.69059154675, 9986.450745209084, 10248.538815753309, 10315.638952636622, 10339.844902326471, 10412.68761937143, 18290.17694203764, 18339.449816505527, 18344.449666510027, 18425.631487370178, 18430.354937577387, 6664.500162487833, 6751.291114433012, 6751.898721519181, 6826.761063362857, 6908.274631163656, 3578.9105272368397, 3629.4374371972385, 3640.3811352069683, 3772.5472943246436, 3795.7532760370486, 2690.381212321138, 2793.0922450203766, 2802.1873656639345, 2803.1310293808983, 2806.396624725653, 488.1116368209824, 495.63075508746215, 499.91501444754476, 503.60215429810773, 510.1404134034164, 508.7557972173378, 514.6063261604876, 520.4041372628319, 525.9192359700775, 529.8595872093898, 7708.807279817937, 8207.138250483733, 8331.95834020838, 8365.916340836635, 8833.867491987625, 411.5555200383578, 498.4093848789124, 505.4616833072766, 519.462356461061, 526.0531044120568, 3668.7437226106285, 3819.866304679323, 4037.1723796621623, 4087.6321131098343, 4181.832726690959, 97542.0, 98970.0, 99000.0, 100753.49623251837, 102095.0, 85152.57423712965, 85634.0, 85815.0, 86258.0, 86422.13577864267, 74552.0, 75695.62152189204, 76338.0, 77639.61180194176, 78112.21887781049, 7618.4667073306555, 7633.961830190813, 7664.693412263447, 7688.884666730115, 8097.2712455879255, 35795.0, 44118.33822492729, 44731.97412232915, 45521.0, 47986.28020579764, 37912.43131352977, 44778.10443791171, 57660.42339576718, 60496.39503605084, 62130.0, 9066.68533062689, 9269.814603707753, 9534.427934323963, 11801.704957376134, 12219.69450763738, 10141.695749127539, 10528.894711052792, 12787.424565894371, 13142.802857956947, 13809.723805523632, 10752.784944300915, 10848.511816968097, 11379.54481820751, 11652.126090543412, 11710.824337635113, 11235.49440275206, 11756.529738810352, 11998.580049698568, 12331.136820422484, 12340.197887137307, 10914.181436392144, 11142.888571114185, 11229.831552526555, 11690.824637630612, 11721.4807753415, 8950.0, 9354.859677104712, 9392.0, 9405.153536181777, 9431.669891553762, 8439.282660973886, 8551.1092452935, 8640.222379985831, 8972.48061823008, 9299.581518831534], "value": 6337.905564400721, "unit": "score"}], "name": "dromaeo_css", "value": 6293.7842683452955, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 113.0, 115.0, 113.0, 114.0, 119.0, 113.0, 113.0, 115.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 129.0, 149.0, 196.0, 125.0, 149.0, 153.0, 141.0, 200.0, 120.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 161.0, 164.0, 163.0, 161.0, 162.0, 163.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 168.0, 76.0, 75.0, 76.0, 77.0, 158.0, 77.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 146.0, 88.0, 87.0, 88.0, 139.0, 86.0, 87.0, 143.0], "value": 104.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 64.0, 64.0, 65.0, 66.0, 64.0, 64.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 67.0, 66.0, 66.0, 67.0, 72.0, 66.0, 67.0], "value": 67.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 86.0, 83.0, 87.0, 82.0, 83.0, 84.0, 85.0, 84.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 136.0, 130.0, 141.0, 143.0, 139.0, 134.0, 133.0, 155.0, 134.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 171.0, 170.0, 168.0, 174.0, 172.0, 172.0, 172.0, 172.0, 175.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 68.0, 70.0, 69.0, 69.0, 69.0, 68.0, 67.0, 72.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1578.5000000000002, "alertThreshold": 2.0}]} 08:33:33 INFO - Return code: 0 08:33:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:33:33 INFO - # TBPL SUCCESS # 08:33:33 INFO - Running post-action listener: _resource_record_post_action 08:33:33 INFO - [mozharness: 2016-08-23 15:33:33.562633Z] Finished run-tests step (success) 08:33:33 INFO - Running post-run listener: _resource_record_post_run 08:33:33 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 16384; Write bytes: 423755776; Read time: 308; Write time: 366884 08:33:33 INFO - TinderboxPrint: CPU usage
13.3% 08:33:33 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 308 08:33:33 INFO - TinderboxPrint: I/O write bytes / time
423,755,776 / 366,884 08:33:33 INFO - TinderboxPrint: CPU idle
8,331.8 (86.7%) 08:33:33 INFO - TinderboxPrint: CPU user
1,207.5 (12.6%) 08:33:33 INFO - TinderboxPrint: Swap in / out
0 / 0 08:33:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 130093056; Read time: 160; Write time: 98560 08:33:33 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293109760; Read time: 140; Write time: 268300 08:33:34 INFO - Running post-run listener: _upload_blobber_files 08:33:34 INFO - Blob upload gear active. 08:33:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:33:34 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 08:33:34 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:33:34 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:33:34 INFO - (blobuploader) - INFO - Open directory for files ... 08:33:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:33:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:33:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:39 INFO - (blobuploader) - INFO - Done attempting. 08:33:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:33:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:33:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:40 INFO - (blobuploader) - INFO - Done attempting. 08:33:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:33:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:33:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:40 INFO - (blobuploader) - INFO - Done attempting. 08:33:40 INFO - (blobuploader) - INFO - Iteration through files over. 08:33:40 INFO - Return code: 0 08:33:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:33:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:33:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ebba9be63dda93a6b012e1c060c97918530706f2975044d271382a3599e619c0e21757808d2da286202be7b99906865871f34e916dbbb98eacab308a3d0ce7c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2b2bb8483d16124ab1d2e8789885fb3d820625def9c4274740a323f9131fc33335e06c2306ec59f520dd878a8bfdf501921a0f0db72354810432d85f9be73b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5dead15d24dcc81453e833d770a413df0df273584864d3d44b0a47a7d6df6e85ab3733e5b113e3238294b7b175cd4d8679e715e19f516ab1d061ec0d32b07ea"} 08:33:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:33:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:33:40 INFO - Contents: 08:33:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ebba9be63dda93a6b012e1c060c97918530706f2975044d271382a3599e619c0e21757808d2da286202be7b99906865871f34e916dbbb98eacab308a3d0ce7c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2b2bb8483d16124ab1d2e8789885fb3d820625def9c4274740a323f9131fc33335e06c2306ec59f520dd878a8bfdf501921a0f0db72354810432d85f9be73b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5dead15d24dcc81453e833d770a413df0df273584864d3d44b0a47a7d6df6e85ab3733e5b113e3238294b7b175cd4d8679e715e19f516ab1d061ec0d32b07ea"} 08:33:40 INFO - Running post-run listener: copy_logs_to_upload_dir 08:33:40 INFO - Copying logs to upload dir... 08:33:40 INFO - mkdir: /builds/slave/test/build/upload/logs 08:33:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.676513 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-23 08:33:40.666847) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 08:33:40.670711) ========= 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=32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ebba9be63dda93a6b012e1c060c97918530706f2975044d271382a3599e619c0e21757808d2da286202be7b99906865871f34e916dbbb98eacab308a3d0ce7c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2b2bb8483d16124ab1d2e8789885fb3d820625def9c4274740a323f9131fc33335e06c2306ec59f520dd878a8bfdf501921a0f0db72354810432d85f9be73b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5dead15d24dcc81453e833d770a413df0df273584864d3d44b0a47a7d6df6e85ab3733e5b113e3238294b7b175cd4d8679e715e19f516ab1d061ec0d32b07ea"} build_url:https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011213 build_url: 'https://queue.taskcluster.net/v1/task/IvulK0foTDCebXLkmi15CQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ebba9be63dda93a6b012e1c060c97918530706f2975044d271382a3599e619c0e21757808d2da286202be7b99906865871f34e916dbbb98eacab308a3d0ce7c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2b2bb8483d16124ab1d2e8789885fb3d820625def9c4274740a323f9131fc33335e06c2306ec59f520dd878a8bfdf501921a0f0db72354810432d85f9be73b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5dead15d24dcc81453e833d770a413df0df273584864d3d44b0a47a7d6df6e85ab3733e5b113e3238294b7b175cd4d8679e715e19f516ab1d061ec0d32b07ea"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 08:33:40.696715) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:33:40.697117) ========= 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=32c5991c409366f7fec8a718000001d2-1471964963.596439-1257694398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:33:40.783239) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 08:33:40.783584) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 08:33:40.783915) ========= ========= Total master_lag: 0.19 =========