builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1472850867.5 results: success (0) buildid: 20160902125250 builduid: 029b55efca37490f850b817d667c992d revision: 38d0defa2db77fa8bf209cf60bde4232896660cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 14:14:27.500711) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 14:14:27.501191) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 14:14:27.501474) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 14:14:27.524498) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:14:27.524895) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-02 14:14:28-- 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% 113M=0s 2016-09-02 14:14:28 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147805 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:14:27.686563) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:14:27.686903) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016138 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:14:27.736531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-02 14:14:27.736899) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 38d0defa2db77fa8bf209cf60bde4232896660cc --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 38d0defa2db77fa8bf209cf60bde4232896660cc --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=97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-02 14:14:28,777 truncating revision to first 12 chars 2016-09-02 14:14:28,777 Setting DEBUG logging. 2016-09-02 14:14:28,777 attempt 1/10 2016-09-02 14:14:28,778 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/38d0defa2db7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-02 14:14:30,116 unpacking tar archive at: mozilla-central-38d0defa2db7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.656803 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-02 14:14:29.407701) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 14:14:29.408028) ========= script_repo_revision: 38d0defa2db77fa8bf209cf60bde4232896660cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 14:14:29.408458) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 14:14:29.408773) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 14:14:29.418239) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-02 14:14:29.418551) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:14:30 INFO - MultiFileLogger online at 20160902 14:14:30 in /builds/slave/test 14:14:30 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 14:14:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:14:30 INFO - {'append_to_log': False, 14:14:30 INFO - 'base_work_dir': '/builds/slave/test', 14:14:30 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:14:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:14:30 INFO - 'branch': 'Firefox-Non-PGO', 14:14:30 INFO - 'buildbot_json_path': 'buildprops.json', 14:14:30 INFO - 'config_files': ('talos/linux_config.py',), 14:14:30 INFO - 'default_actions': ('clobber', 14:14:30 INFO - 'read-buildbot-config', 14:14:30 INFO - 'download-and-extract', 14:14:30 INFO - 'populate-webroot', 14:14:30 INFO - 'create-virtualenv', 14:14:30 INFO - 'install', 14:14:30 INFO - 'run-tests'), 14:14:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:14:30 INFO - 'download_minidump_stackwalk': True, 14:14:30 INFO - 'download_symbols': 'ondemand', 14:14:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:14:30 INFO - 'tooltool.py': '/tools/tooltool.py', 14:14:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:14:30 INFO - '/tools/misc-python/virtualenv.py')}, 14:14:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:14:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:14:30 INFO - 'installer_path': 'installer.exe', 14:14:30 INFO - 'log_level': 'info', 14:14:30 INFO - 'log_name': 'talos', 14:14:30 INFO - 'log_to_console': True, 14:14:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:14:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:14:30 INFO - 'opt_config_files': (), 14:14:30 INFO - 'pip_index': False, 14:14:30 INFO - 'sps_profile': False, 14:14:30 INFO - 'sps_profile_interval': 0, 14:14:30 INFO - 'suite': 'dromaeojs', 14:14:30 INFO - 'system_bits': '32', 14:14:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:14:30 INFO - 'title': 'talos-linux64-ix-068', 14:14:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:14:30 INFO - 'use_talos_json': True, 14:14:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:14:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:14:30 INFO - 'work_dir': 'build'} 14:14:30 INFO - [mozharness: 2016-09-02 21:14:30.556681Z] Running clobber step. 14:14:30 INFO - Running pre-action listener: _resource_record_pre_action 14:14:30 INFO - Running main action method: clobber 14:14:30 INFO - rmtree: /builds/slave/test/build 14:14:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:14:31 INFO - Running post-action listener: _resource_record_post_action 14:14:31 INFO - [mozharness: 2016-09-02 21:14:31.015981Z] Finished clobber step (success) 14:14:31 INFO - [mozharness: 2016-09-02 21:14:31.016083Z] Running read-buildbot-config step. 14:14:31 INFO - Running pre-action listener: _resource_record_pre_action 14:14:31 INFO - Running main action method: read_buildbot_config 14:14:31 INFO - Using buildbot properties: 14:14:31 INFO - { 14:14:31 INFO - "project": "", 14:14:31 INFO - "product": "firefox", 14:14:31 INFO - "script_repo_revision": "production", 14:14:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 14:14:31 INFO - "repository": "", 14:14:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 14:14:31 INFO - "buildid": "20160902125250", 14:14:31 INFO - "pgo_build": "False", 14:14:31 INFO - "basedir": "/builds/slave/test", 14:14:31 INFO - "buildnumber": 704, 14:14:31 INFO - "slavename": "talos-linux64-ix-068", 14:14:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:14:31 INFO - "platform": "ubuntu64_hw", 14:14:31 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 14:14:31 INFO - "branch": "mozilla-central", 14:14:31 INFO - "repo_path": "mozilla-central", 14:14:31 INFO - "revision": "38d0defa2db77fa8bf209cf60bde4232896660cc", 14:14:31 INFO - "stage_platform": "linux64", 14:14:31 INFO - "builduid": "029b55efca37490f850b817d667c992d", 14:14:31 INFO - "slavebuilddir": "test" 14:14:31 INFO - } 14:14:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/eU2wsUGRQjKxb_STbQntAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 14:14:31 INFO - Running post-action listener: _resource_record_post_action 14:14:31 INFO - [mozharness: 2016-09-02 21:14:31.018574Z] Finished read-buildbot-config step (success) 14:14:31 INFO - [mozharness: 2016-09-02 21:14:31.018662Z] Running download-and-extract step. 14:14:31 INFO - Running pre-action listener: _resource_record_pre_action 14:14:31 INFO - Running main action method: download_and_extract 14:14:31 INFO - mkdir: /builds/slave/test/build/tests 14:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:31 INFO - trying https://queue.taskcluster.net/v1/task/eU2wsUGRQjKxb_STbQntAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:14:31 INFO - Downloading https://queue.taskcluster.net/v1/task/eU2wsUGRQjKxb_STbQntAg/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 14:14:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eU2wsUGRQjKxb_STbQntAg/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 14:14:31 INFO - Downloaded 1361 bytes. 14:14:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:14:31 INFO - Using the following test package requirements: 14:14:31 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:14:31 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:14:31 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:14:31 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:31 INFO - u'jsshell-linux-x86_64.zip'], 14:14:31 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:14:31 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:14:31 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:14:31 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:14:31 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:14:31 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:14:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:31 INFO - trying https://queue.taskcluster.net/v1/task/eU2wsUGRQjKxb_STbQntAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:14:31 INFO - Downloading https://queue.taskcluster.net/v1/task/eU2wsUGRQjKxb_STbQntAg/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 14:14:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eU2wsUGRQjKxb_STbQntAg/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 14:14:32 INFO - Downloaded 20334661 bytes. 14:14:32 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 14:14:36 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 14:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:36 INFO - trying https://queue.taskcluster.net/v1/task/eU2wsUGRQjKxb_STbQntAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:14:36 INFO - Downloading https://queue.taskcluster.net/v1/task/eU2wsUGRQjKxb_STbQntAg/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 14:14:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eU2wsUGRQjKxb_STbQntAg/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 14:14:37 INFO - Downloaded 20334661 bytes. 14:14:37 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 14:14:42 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')]} 14:14:42 INFO - trying https://queue.taskcluster.net/v1/task/eU2wsUGRQjKxb_STbQntAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 14:14:42 INFO - Downloading https://queue.taskcluster.net/v1/task/eU2wsUGRQjKxb_STbQntAg/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 14:14:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eU2wsUGRQjKxb_STbQntAg/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 14:14:43 INFO - Downloaded 14413998 bytes. 14:14:43 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 14:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:43 INFO - trying https://queue.taskcluster.net/v1/task/eU2wsUGRQjKxb_STbQntAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:14:43 INFO - Downloading https://queue.taskcluster.net/v1/task/eU2wsUGRQjKxb_STbQntAg/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 14:14:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eU2wsUGRQjKxb_STbQntAg/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 14:14:45 INFO - Downloaded 55868878 bytes. 14:14:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eU2wsUGRQjKxb_STbQntAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:14:45 INFO - mkdir: /builds/slave/test/properties 14:14:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:14:45 INFO - Writing to file /builds/slave/test/properties/build_url 14:14:45 INFO - Contents: 14:14:45 INFO - build_url:https://queue.taskcluster.net/v1/task/eU2wsUGRQjKxb_STbQntAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:14:45 INFO - Running post-action listener: _resource_record_post_action 14:14:45 INFO - Running post-action listener: set_extra_try_arguments 14:14:45 INFO - [mozharness: 2016-09-02 21:14:45.660132Z] Finished download-and-extract step (success) 14:14:45 INFO - [mozharness: 2016-09-02 21:14:45.660479Z] Running populate-webroot step. 14:14:45 INFO - Running pre-action listener: _resource_record_pre_action 14:14:45 INFO - Running main action method: populate_webroot 14:14:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:14:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:14:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:14:45 INFO - '--tppagecycles', 14:14:45 INFO - '7'], 14:14:45 INFO - 'tests': ['tsvgm']}}, 14:14:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:14:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:14:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:14:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:14:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:14:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:14:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:45 INFO - 'talos_options': ['--disable-e10s'], 14:14:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:14:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:14:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:45 INFO - 'talos_options': ['--disable-e10s'], 14:14:45 INFO - 'tests': ['damp', 'tps']}, 14:14:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:45 INFO - 'tests': ['damp', 'tps']}, 14:14:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:14:45 INFO - 'tests': ['dromaeo_dom']}, 14:14:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:14:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:14:45 INFO - 'tests': ['basic_compositor_video']}, 14:14:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:14:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:14:45 INFO - 'tests': ['a11yr', 14:14:45 INFO - 'ts_paint', 14:14:45 INFO - 'tpaint', 14:14:45 INFO - 'sessionrestore', 14:14:45 INFO - 'sessionrestore_no_auto_restore', 14:14:45 INFO - 'tabpaint']}, 14:14:45 INFO - 'other-e10s': {'tests': ['a11yr', 14:14:45 INFO - 'ts_paint', 14:14:45 INFO - 'tpaint', 14:14:45 INFO - 'sessionrestore', 14:14:45 INFO - 'sessionrestore_no_auto_restore', 14:14:45 INFO - 'tabpaint']}, 14:14:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:14:45 INFO - 'ts_paint', 14:14:45 INFO - 'tpaint', 14:14:45 INFO - 'sessionrestore', 14:14:45 INFO - 'sessionrestore_no_auto_restore', 14:14:45 INFO - 'tabpaint']}, 14:14:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:14:45 INFO - 'ts_paint', 14:14:45 INFO - 'tpaint', 14:14:45 INFO - 'sessionrestore', 14:14:45 INFO - 'sessionrestore_no_auto_restore', 14:14:45 INFO - 'tabpaint']}, 14:14:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:14:45 INFO - 'tests': ['a11yr', 14:14:45 INFO - 'ts_paint', 14:14:45 INFO - 'tpaint', 14:14:45 INFO - 'sessionrestore', 14:14:45 INFO - 'sessionrestore_no_auto_restore', 14:14:45 INFO - 'tabpaint']}, 14:14:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:14:45 INFO - 'tests': ['a11yr', 14:14:45 INFO - 'ts_paint', 14:14:45 INFO - 'tpaint', 14:14:45 INFO - 'sessionrestore', 14:14:45 INFO - 'sessionrestore_no_auto_restore', 14:14:45 INFO - 'tabpaint']}, 14:14:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:14:45 INFO - 'tests': ['tsvgx', 14:14:45 INFO - 'tsvgr_opacity', 14:14:45 INFO - 'tart', 14:14:45 INFO - 'tscrollx', 14:14:45 INFO - 'cart']}, 14:14:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:14:45 INFO - 'tsvgr_opacity', 14:14:45 INFO - 'tart', 14:14:45 INFO - 'tscrollx', 14:14:45 INFO - 'cart']}, 14:14:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:45 INFO - 'talos_options': ['--disable-e10s'], 14:14:45 INFO - 'tests': ['tp5o']}, 14:14:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:45 INFO - 'tests': ['tp5o']}, 14:14:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:45 INFO - 'talos_options': ['--disable-e10s', 14:14:45 INFO - '--xperf_path', 14:14:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:14:45 INFO - 'tests': ['tp5n']}, 14:14:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:45 INFO - 'talos_options': ['--xperf_path', 14:14:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:14:45 INFO - 'tests': ['tp5n']}}, 14:14:45 INFO - 'talos.zip': {'path': '', 14:14:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:14:45 INFO - Running post-action listener: _resource_record_post_action 14:14:45 INFO - [mozharness: 2016-09-02 21:14:45.677795Z] Finished populate-webroot step (success) 14:14:45 INFO - [mozharness: 2016-09-02 21:14:45.677890Z] Running create-virtualenv step. 14:14:45 INFO - Running pre-action listener: _resource_record_pre_action 14:14:45 INFO - Running main action method: create_virtualenv 14:14:45 INFO - Creating virtualenv /builds/slave/test/build/venv 14:14:45 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 14:14:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:14:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:14:45 INFO - Using real prefix '/usr' 14:14:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:14:46 INFO - Installing distribute.............................................................................................................................................................................................done. 14:14:48 INFO - Installing pip.................done. 14:14:48 INFO - Return code: 0 14:14:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:48 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 0x7fdfe7df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x293b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2935090>, '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 0x29389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2938e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727', '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 14:14:48 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 14:14:48 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 14:14:48 INFO - Using env: {'DISPLAY': ':0', 14:14:48 INFO - 'HOME': '/home/cltbld', 14:14:48 INFO - 'LANG': 'en_US.UTF-8', 14:14:48 INFO - 'LANGUAGE': 'en_US:en', 14:14:48 INFO - 'LOGNAME': 'cltbld', 14:14:48 INFO - 'MAIL': '/var/mail/cltbld', 14:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:48 INFO - 'MOZ_NO_REMOTE': '1', 14:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:48 INFO - 'NO_EM_RESTART': '1', 14:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:48 INFO - 'PWD': '/builds/slave/test', 14:14:48 INFO - 'SHELL': '/bin/bash', 14:14:48 INFO - 'SHLVL': '1', 14:14:48 INFO - 'TERM': 'linux', 14:14:48 INFO - 'TMOUT': '86400', 14:14:48 INFO - 'USER': 'cltbld', 14:14:48 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727', 14:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:48 INFO - '_': '/tools/buildbot/bin/python'} 14:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:48 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 14:14:48 INFO - Cleaning up... 14:14:48 INFO - Return code: 0 14:14:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:48 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 0x7fdfe7df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x293b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2935090>, '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 0x29389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2938e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727', '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 14:14:48 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 14:14:48 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 14:14:48 INFO - Using env: {'DISPLAY': ':0', 14:14:48 INFO - 'HOME': '/home/cltbld', 14:14:48 INFO - 'LANG': 'en_US.UTF-8', 14:14:48 INFO - 'LANGUAGE': 'en_US:en', 14:14:48 INFO - 'LOGNAME': 'cltbld', 14:14:48 INFO - 'MAIL': '/var/mail/cltbld', 14:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:48 INFO - 'MOZ_NO_REMOTE': '1', 14:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:48 INFO - 'NO_EM_RESTART': '1', 14:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:48 INFO - 'PWD': '/builds/slave/test', 14:14:48 INFO - 'SHELL': '/bin/bash', 14:14:48 INFO - 'SHLVL': '1', 14:14:48 INFO - 'TERM': 'linux', 14:14:48 INFO - 'TMOUT': '86400', 14:14:48 INFO - 'USER': 'cltbld', 14:14:48 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727', 14:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:48 INFO - '_': '/tools/buildbot/bin/python'} 14:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:48 INFO - Downloading/unpacking psutil>=3.1.1 14:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:14:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:14:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:14:50 INFO - Installing collected packages: psutil 14:14:50 INFO - Running setup.py install for psutil 14:14:50 INFO - building 'psutil._psutil_linux' extension 14:14:50 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 14:14:51 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 14:14:51 INFO - building 'psutil._psutil_posix' extension 14:14:51 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 14:14:51 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 14:14:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:14:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:14:51 INFO - Successfully installed psutil 14:14:51 INFO - Cleaning up... 14:14:51 INFO - Return code: 0 14:14:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:14:51 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')]} 14:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:51 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')]} 14:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:51 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 0x7fdfe7df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x293b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2935090>, '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 0x29389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2938e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727', '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 14:14:51 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 14:14:51 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 14:14:51 INFO - Using env: {'DISPLAY': ':0', 14:14:51 INFO - 'HOME': '/home/cltbld', 14:14:51 INFO - 'LANG': 'en_US.UTF-8', 14:14:51 INFO - 'LANGUAGE': 'en_US:en', 14:14:51 INFO - 'LOGNAME': 'cltbld', 14:14:51 INFO - 'MAIL': '/var/mail/cltbld', 14:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:51 INFO - 'MOZ_NO_REMOTE': '1', 14:14:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:51 INFO - 'NO_EM_RESTART': '1', 14:14:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:51 INFO - 'PWD': '/builds/slave/test', 14:14:51 INFO - 'SHELL': '/bin/bash', 14:14:51 INFO - 'SHLVL': '1', 14:14:51 INFO - 'TERM': 'linux', 14:14:51 INFO - 'TMOUT': '86400', 14:14:51 INFO - 'USER': 'cltbld', 14:14:51 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727', 14:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:51 INFO - '_': '/tools/buildbot/bin/python'} 14:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:14:51 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 14:14:51 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 14:14:51 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 14:14:51 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 14:14:51 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 14:14:51 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 14:14:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:14:53 INFO - Installing collected packages: mozsystemmonitor 14:14:53 INFO - Running setup.py install for mozsystemmonitor 14:14:53 INFO - Successfully installed mozsystemmonitor 14:14:53 INFO - Cleaning up... 14:14:53 INFO - Return code: 0 14:14:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:14: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')]} 14:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14: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')]} 14:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:53 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 0x7fdfe7df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x293b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2935090>, '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 0x29389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2938e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727', '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 14:14:53 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 14:14:53 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 14:14:53 INFO - Using env: {'DISPLAY': ':0', 14:14:53 INFO - 'HOME': '/home/cltbld', 14:14:53 INFO - 'LANG': 'en_US.UTF-8', 14:14:53 INFO - 'LANGUAGE': 'en_US:en', 14:14:53 INFO - 'LOGNAME': 'cltbld', 14:14:53 INFO - 'MAIL': '/var/mail/cltbld', 14:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:53 INFO - 'MOZ_NO_REMOTE': '1', 14:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:53 INFO - 'NO_EM_RESTART': '1', 14:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:53 INFO - 'PWD': '/builds/slave/test', 14:14:53 INFO - 'SHELL': '/bin/bash', 14:14:53 INFO - 'SHLVL': '1', 14:14:53 INFO - 'TERM': 'linux', 14:14:53 INFO - 'TMOUT': '86400', 14:14:53 INFO - 'USER': 'cltbld', 14:14:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727', 14:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:53 INFO - '_': '/tools/buildbot/bin/python'} 14:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:53 INFO - Downloading/unpacking jsonschema==2.5.1 14:14:53 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 14:14:53 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 14:14:53 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 14:14:53 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 14:14:53 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 14:14:53 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 14:14:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:14:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:14:55 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 14:14:55 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 14:14:55 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 14:14:55 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 14:14:55 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 14:14:55 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 14:14:55 INFO - Downloading functools32-3.2.3-2.tar.gz 14:14:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:14:55 INFO - warning: no files found matching '*.txt' 14:14:55 INFO - no previously-included directories found matching 'build' 14:14:55 INFO - no previously-included directories found matching 'dist' 14:14:55 INFO - no previously-included directories found matching '.git*' 14:14:55 INFO - Installing collected packages: jsonschema, functools32 14:14:56 INFO - Running setup.py install for functools32 14:14:56 INFO - warning: no files found matching '*.txt' 14:14:56 INFO - no previously-included directories found matching 'build' 14:14:56 INFO - no previously-included directories found matching 'dist' 14:14:56 INFO - no previously-included directories found matching '.git*' 14:14:56 INFO - Successfully installed jsonschema functools32 14:14:56 INFO - Cleaning up... 14:14:56 INFO - Return code: 0 14:14:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:14:56 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')]} 14:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:56 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')]} 14:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:56 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 0x7fdfe7df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x293b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2935090>, '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 0x29389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2938e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727', '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 14:14:56 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 14:14:56 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 14:14:56 INFO - Using env: {'DISPLAY': ':0', 14:14:56 INFO - 'HOME': '/home/cltbld', 14:14:56 INFO - 'LANG': 'en_US.UTF-8', 14:14:56 INFO - 'LANGUAGE': 'en_US:en', 14:14:56 INFO - 'LOGNAME': 'cltbld', 14:14:56 INFO - 'MAIL': '/var/mail/cltbld', 14:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:56 INFO - 'MOZ_NO_REMOTE': '1', 14:14:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:56 INFO - 'NO_EM_RESTART': '1', 14:14:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:56 INFO - 'PWD': '/builds/slave/test', 14:14:56 INFO - 'SHELL': '/bin/bash', 14:14:56 INFO - 'SHLVL': '1', 14:14:56 INFO - 'TERM': 'linux', 14:14:56 INFO - 'TMOUT': '86400', 14:14:56 INFO - 'USER': 'cltbld', 14:14:56 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727', 14:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:56 INFO - '_': '/tools/buildbot/bin/python'} 14:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:14:56 INFO - Cleaning up... 14:14:56 INFO - Return code: 0 14:14:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:14:56 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')]} 14:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:56 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')]} 14:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:56 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 0x7fdfe7df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x293b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2935090>, '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 0x29389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2938e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727', '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 14:14:56 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 14:14:56 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 14:14:56 INFO - Using env: {'DISPLAY': ':0', 14:14:56 INFO - 'HOME': '/home/cltbld', 14:14:56 INFO - 'LANG': 'en_US.UTF-8', 14:14:56 INFO - 'LANGUAGE': 'en_US:en', 14:14:56 INFO - 'LOGNAME': 'cltbld', 14:14:56 INFO - 'MAIL': '/var/mail/cltbld', 14:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:56 INFO - 'MOZ_NO_REMOTE': '1', 14:14:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:56 INFO - 'NO_EM_RESTART': '1', 14:14:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:56 INFO - 'PWD': '/builds/slave/test', 14:14:56 INFO - 'SHELL': '/bin/bash', 14:14:56 INFO - 'SHLVL': '1', 14:14:56 INFO - 'TERM': 'linux', 14:14:56 INFO - 'TMOUT': '86400', 14:14:56 INFO - 'USER': 'cltbld', 14:14:56 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727', 14:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:56 INFO - '_': '/tools/buildbot/bin/python'} 14:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:56 INFO - Downloading/unpacking blobuploader==1.2.4 14:14:56 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 14:14:56 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 14:14:56 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 14:14:56 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 14:14:56 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 14:14:56 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 14:14:58 INFO - Downloading blobuploader-1.2.4.tar.gz 14:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:14:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:14:58 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 14:14:58 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 14:14:58 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 14:14:58 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 14:14:58 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 14:14:58 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 14:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:14:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:14:58 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 14:14:58 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 14:14:58 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 14:14:58 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 14:14:58 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 14:14:58 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 14:14:59 INFO - Downloading docopt-0.6.1.tar.gz 14:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:14:59 INFO - Installing collected packages: blobuploader, requests, docopt 14:14:59 INFO - Running setup.py install for blobuploader 14:14:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:14:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:14:59 INFO - Running setup.py install for requests 14:14:59 INFO - Running setup.py install for docopt 14:14:59 INFO - Successfully installed blobuploader requests docopt 14:14:59 INFO - Cleaning up... 14:14:59 INFO - Return code: 0 14:14:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:14: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')]} 14:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14: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')]} 14:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:59 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 0x7fdfe7df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x293b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2935090>, '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 0x29389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2938e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727', '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 14:14:59 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 14:14:59 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 14:14:59 INFO - Using env: {'DISPLAY': ':0', 14:14:59 INFO - 'HOME': '/home/cltbld', 14:14:59 INFO - 'LANG': 'en_US.UTF-8', 14:14:59 INFO - 'LANGUAGE': 'en_US:en', 14:14:59 INFO - 'LOGNAME': 'cltbld', 14:14:59 INFO - 'MAIL': '/var/mail/cltbld', 14:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:59 INFO - 'MOZ_NO_REMOTE': '1', 14:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:59 INFO - 'NO_EM_RESTART': '1', 14:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:59 INFO - 'PWD': '/builds/slave/test', 14:14:59 INFO - 'SHELL': '/bin/bash', 14:14:59 INFO - 'SHLVL': '1', 14:14:59 INFO - 'TERM': 'linux', 14:14:59 INFO - 'TMOUT': '86400', 14:14:59 INFO - 'USER': 'cltbld', 14:14:59 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727', 14:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:59 INFO - '_': '/tools/buildbot/bin/python'} 14:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:00 INFO - Running setup.py (path:/tmp/pip-Y1u_AD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:00 INFO - Running setup.py (path:/tmp/pip-J1Z3uE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:00 INFO - Running setup.py (path:/tmp/pip-o4M6RX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:00 INFO - Running setup.py (path:/tmp/pip-DewL5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:00 INFO - Running setup.py (path:/tmp/pip-p5Xnqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:00 INFO - Running setup.py (path:/tmp/pip-chiwgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:00 INFO - Running setup.py (path:/tmp/pip-g5qCXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:00 INFO - Running setup.py (path:/tmp/pip-8GAh82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:00 INFO - Running setup.py (path:/tmp/pip-b4SeXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:00 INFO - Running setup.py (path:/tmp/pip-e1V_iZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:00 INFO - Running setup.py (path:/tmp/pip-_iYhzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:00 INFO - Running setup.py (path:/tmp/pip-7fPcjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:00 INFO - Running setup.py (path:/tmp/pip-0HAX_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:01 INFO - Running setup.py (path:/tmp/pip-whzxue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:01 INFO - Running setup.py (path:/tmp/pip-0hA_BT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:01 INFO - Running setup.py (path:/tmp/pip-wx8b8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:01 INFO - Running setup.py (path:/tmp/pip-GuyeqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:15:01 INFO - Running setup.py install for manifestparser 14:15:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:15:01 INFO - Running setup.py install for mozcrash 14:15:01 INFO - Running setup.py install for mozdebug 14:15:01 INFO - Running setup.py install for mozdevice 14:15:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:15:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:15:01 INFO - Running setup.py install for mozfile 14:15:01 INFO - Running setup.py install for mozhttpd 14:15:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:15:01 INFO - Running setup.py install for mozinfo 14:15:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:15:02 INFO - Running setup.py install for mozInstall 14:15:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:15:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:15:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:15:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:15:02 INFO - Running setup.py install for mozleak 14:15:02 INFO - Running setup.py install for mozlog 14:15:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:15:02 INFO - Running setup.py install for moznetwork 14:15:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:15:02 INFO - Running setup.py install for mozprocess 14:15:02 INFO - Running setup.py install for mozprofile 14:15:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:15:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:15:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:15:02 INFO - Running setup.py install for mozrunner 14:15:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:15:02 INFO - Running setup.py install for mozscreenshot 14:15:02 INFO - Running setup.py install for moztest 14:15:03 INFO - Running setup.py install for mozversion 14:15:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:15:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:15:03 INFO - Cleaning up... 14:15:03 INFO - Return code: 0 14:15:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:03 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')]} 14:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:03 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')]} 14:15:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:03 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 0x7fdfe7df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x293b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2935090>, '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 0x29389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2938e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727', '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 14:15:03 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 14:15:03 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 14:15:03 INFO - Using env: {'DISPLAY': ':0', 14:15:03 INFO - 'HOME': '/home/cltbld', 14:15:03 INFO - 'LANG': 'en_US.UTF-8', 14:15:03 INFO - 'LANGUAGE': 'en_US:en', 14:15:03 INFO - 'LOGNAME': 'cltbld', 14:15:03 INFO - 'MAIL': '/var/mail/cltbld', 14:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:03 INFO - 'MOZ_NO_REMOTE': '1', 14:15:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:03 INFO - 'NO_EM_RESTART': '1', 14:15:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:03 INFO - 'PWD': '/builds/slave/test', 14:15:03 INFO - 'SHELL': '/bin/bash', 14:15:03 INFO - 'SHLVL': '1', 14:15:03 INFO - 'TERM': 'linux', 14:15:03 INFO - 'TMOUT': '86400', 14:15:03 INFO - 'USER': 'cltbld', 14:15:03 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727', 14:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:03 INFO - '_': '/tools/buildbot/bin/python'} 14:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:03 INFO - Running setup.py (path:/tmp/pip-rcU3P3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:03 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)) 14:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:03 INFO - Running setup.py (path:/tmp/pip-cW4gnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:03 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)) 14:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:03 INFO - Running setup.py (path:/tmp/pip-mdzTP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:03 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)) 14:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:03 INFO - Running setup.py (path:/tmp/pip-sw31cH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:03 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)) 14:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:03 INFO - Running setup.py (path:/tmp/pip-U3aPIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:03 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)) 14:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:03 INFO - Running setup.py (path:/tmp/pip-IPvvvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:03 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)) 14:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:03 INFO - Running setup.py (path:/tmp/pip-85Gg8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:03 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)) 14:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:03 INFO - Running setup.py (path:/tmp/pip-fII0V_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:03 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)) 14:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:03 INFO - Running setup.py (path:/tmp/pip-mZcdUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:04 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)) 14:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:04 INFO - Running setup.py (path:/tmp/pip-a7Zl0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:04 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)) 14:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:04 INFO - Running setup.py (path:/tmp/pip-gi7fFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:04 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)) 14:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:04 INFO - Running setup.py (path:/tmp/pip-JCbsVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:04 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)) 14:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:04 INFO - Running setup.py (path:/tmp/pip-dtEP2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:04 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)) 14:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:04 INFO - Running setup.py (path:/tmp/pip-HOStGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:04 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)) 14:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:04 INFO - Running setup.py (path:/tmp/pip-JDMIhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:04 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)) 14:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:04 INFO - Running setup.py (path:/tmp/pip-2Tcio_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:04 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)) 14:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:04 INFO - Running setup.py (path:/tmp/pip-n3AdVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:04 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)) 14:15:04 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)) 14:15:04 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)) 14:15:04 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)) 14:15:04 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)) 14:15:04 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)) 14:15:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:15:04 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 14:15:04 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 14:15:04 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 14:15:04 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 14:15:04 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 14:15:04 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 14:15:06 INFO - Downloading blessings-1.6.tar.gz 14:15:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:15:06 INFO - Installing collected packages: blessings 14:15:06 INFO - Running setup.py install for blessings 14:15:06 INFO - Successfully installed blessings 14:15:06 INFO - Cleaning up... 14:15:06 INFO - Return code: 0 14:15:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:15:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:15:06 INFO - Reading from file tmpfile_stdout 14:15:06 INFO - Current package versions: 14:15:06 INFO - argparse == 1.2.1 14:15:06 INFO - blessings == 1.6 14:15:06 INFO - blobuploader == 1.2.4 14:15:06 INFO - docopt == 0.6.1 14:15:06 INFO - functools32 == 3.2.3-2 14:15:06 INFO - jsonschema == 2.5.1 14:15:06 INFO - manifestparser == 1.1 14:15:06 INFO - mozInstall == 1.12 14:15:06 INFO - mozcrash == 0.17 14:15:06 INFO - mozdebug == 0.1 14:15:06 INFO - mozdevice == 0.48 14:15:06 INFO - mozfile == 1.2 14:15:06 INFO - mozhttpd == 0.7 14:15:06 INFO - mozinfo == 0.9 14:15:06 INFO - mozleak == 0.1 14:15:06 INFO - mozlog == 3.3 14:15:06 INFO - moznetwork == 0.27 14:15:06 INFO - mozprocess == 0.23 14:15:06 INFO - mozprofile == 0.28 14:15:06 INFO - mozrunner == 6.12 14:15:06 INFO - mozscreenshot == 0.1 14:15:06 INFO - mozsystemmonitor == 0.3 14:15:06 INFO - moztest == 0.7 14:15:06 INFO - mozversion == 1.4 14:15:06 INFO - psutil == 3.1.1 14:15:06 INFO - requests == 1.2.3 14:15:06 INFO - wsgiref == 0.1.2 14:15:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:06 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 0x7fdfe7df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x293b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2935090>, '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 0x29389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2938e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727', '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 14:15:06 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 14:15:06 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 14:15:06 INFO - Using env: {'DISPLAY': ':0', 14:15:06 INFO - 'HOME': '/home/cltbld', 14:15:06 INFO - 'LANG': 'en_US.UTF-8', 14:15:06 INFO - 'LANGUAGE': 'en_US:en', 14:15:06 INFO - 'LOGNAME': 'cltbld', 14:15:06 INFO - 'MAIL': '/var/mail/cltbld', 14:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:06 INFO - 'MOZ_NO_REMOTE': '1', 14:15:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:06 INFO - 'NO_EM_RESTART': '1', 14:15:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:06 INFO - 'PWD': '/builds/slave/test', 14:15:06 INFO - 'SHELL': '/bin/bash', 14:15:06 INFO - 'SHLVL': '1', 14:15:06 INFO - 'TERM': 'linux', 14:15:06 INFO - 'TMOUT': '86400', 14:15:06 INFO - 'USER': 'cltbld', 14:15:06 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727', 14:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:06 INFO - '_': '/tools/buildbot/bin/python'} 14:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:07 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)) 14:15:07 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)) 14:15:07 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)) 14:15:07 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)) 14:15:07 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)) 14:15:07 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)) 14:15:07 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)) 14:15:07 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)) 14:15:07 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)) 14:15:07 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)) 14:15:07 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)) 14:15:07 INFO - Cleaning up... 14:15:07 INFO - Return code: 0 14:15:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:15:07 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')]} 14:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:07 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')]} 14:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:07 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 0x7fdfe7df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x293b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2935090>, '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 0x29389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2938e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727', '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 14:15:07 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 14:15:07 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 14:15:07 INFO - Using env: {'DISPLAY': ':0', 14:15:07 INFO - 'HOME': '/home/cltbld', 14:15:07 INFO - 'LANG': 'en_US.UTF-8', 14:15:07 INFO - 'LANGUAGE': 'en_US:en', 14:15:07 INFO - 'LOGNAME': 'cltbld', 14:15:07 INFO - 'MAIL': '/var/mail/cltbld', 14:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:07 INFO - 'MOZ_NO_REMOTE': '1', 14:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:07 INFO - 'NO_EM_RESTART': '1', 14:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:07 INFO - 'PWD': '/builds/slave/test', 14:15:07 INFO - 'SHELL': '/bin/bash', 14:15:07 INFO - 'SHLVL': '1', 14:15:07 INFO - 'TERM': 'linux', 14:15:07 INFO - 'TMOUT': '86400', 14:15:07 INFO - 'USER': 'cltbld', 14:15:07 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727', 14:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:07 INFO - '_': '/tools/buildbot/bin/python'} 14:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:15:07 INFO - Cleaning up... 14:15:07 INFO - Return code: 0 14:15:07 INFO - Running post-action listener: _resource_record_post_action 14:15:07 INFO - Running post-action listener: _start_resource_monitoring 14:15:07 INFO - Starting resource monitoring. 14:15:07 INFO - [mozharness: 2016-09-02 21:15:07.434316Z] Finished create-virtualenv step (success) 14:15:07 INFO - [mozharness: 2016-09-02 21:15:07.434818Z] Running install step. 14:15:07 INFO - Running pre-action listener: _resource_record_pre_action 14:15:07 INFO - Running main action method: install 14:15:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:15:07 INFO - Reading from file tmpfile_stdout 14:15:07 INFO - Detecting whether we're running mozinstall >=1.0... 14:15:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:15:07 INFO - Reading from file tmpfile_stdout 14:15:07 INFO - Output received: 14:15:07 INFO - Usage: mozinstall [options] installer 14:15:07 INFO - Options: 14:15:07 INFO - -h, --help show this help message and exit 14:15:07 INFO - -d DEST, --destination=DEST 14:15:07 INFO - Directory to install application into. [default: 14:15:07 INFO - "/builds/slave/test"] 14:15:07 INFO - --app=APP Application being installed. [default: firefox] 14:15:07 INFO - mkdir: /builds/slave/test/build/application 14:15:07 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'] 14:15:07 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 14:15:23 INFO - Reading from file tmpfile_stdout 14:15:23 INFO - Output received: 14:15:23 INFO - /builds/slave/test/build/application/firefox/firefox 14:15:23 INFO - Running post-action listener: _resource_record_post_action 14:15:23 INFO - [mozharness: 2016-09-02 21:15:23.884751Z] Finished install step (success) 14:15:23 INFO - [mozharness: 2016-09-02 21:15:23.885028Z] Running run-tests step. 14:15:23 INFO - Running pre-action listener: _resource_record_pre_action 14:15:23 INFO - Running main action method: run_tests 14:15:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:15:23 INFO - Python 2.7.3 14:15:23 INFO - Return code: 0 14:15:23 INFO - grabbing minidump binary from tooltool 14:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:23 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 0x2935090>, '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 0x29389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2938e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:15:23 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 14:15:23 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 14:15:23 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 14:15:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:15:23 INFO - Return code: 0 14:15:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:15:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:15:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:15:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:15:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:15:23 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/eU2wsUGRQjKxb_STbQntAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 14:15:23 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/eU2wsUGRQjKxb_STbQntAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 14:15:23 INFO - Using env: {'DISPLAY': ':0', 14:15:23 INFO - 'HOME': '/home/cltbld', 14:15:23 INFO - 'LANG': 'en_US.UTF-8', 14:15:23 INFO - 'LANGUAGE': 'en_US:en', 14:15:23 INFO - 'LOGNAME': 'cltbld', 14:15:23 INFO - 'MAIL': '/var/mail/cltbld', 14:15:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:15:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:23 INFO - 'MOZ_NO_REMOTE': '1', 14:15:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:15:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:23 INFO - 'NO_EM_RESTART': '1', 14:15:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:23 INFO - 'PWD': '/builds/slave/test', 14:15:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:15:23 INFO - 'SHELL': '/bin/bash', 14:15:23 INFO - 'SHLVL': '1', 14:15:23 INFO - 'TERM': 'linux', 14:15:23 INFO - 'TMOUT': '86400', 14:15:23 INFO - 'USER': 'cltbld', 14:15:23 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727', 14:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:23 INFO - '_': '/tools/buildbot/bin/python'} 14:15:23 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/eU2wsUGRQjKxb_STbQntAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 14:15:24 INFO - mozversion application_buildid: 20160902125250 14:15:24 INFO - mozversion application_changeset: 38d0defa2db77fa8bf209cf60bde4232896660cc 14:15:24 INFO - mozversion application_display_name: Nightly 14:15:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:15:24 INFO - mozversion application_name: Firefox 14:15:24 INFO - mozversion application_remotingname: firefox 14:15:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:15:24 INFO - mozversion application_vendor: Mozilla 14:15:24 INFO - mozversion application_version: 51.0a1 14:15:24 INFO - mozversion platform_buildid: 20160902125250 14:15:24 INFO - mozversion platform_changeset: 38d0defa2db77fa8bf209cf60bde4232896660cc 14:15:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:15:24 INFO - mozversion platform_version: 51.0a1 14:15:24 INFO - using testdate: 1472850924 14:15:24 INFO - actual date: 1472850924 14:15:24 INFO - starting webserver on 'localhost:39792' 14:15:24 INFO - SUITE-START | Running 2 tests 14:15:24 INFO - TEST-START | dromaeo_css 14:15:24 INFO - operating with platform_type : linux_ 14:15:24 INFO - Initialising browser for dromaeo_css test... 14:15:24 INFO - TEST-INFO | started process 16716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE3m9CS/profile http://localhost:39792/getInfo.html) 14:15:28 INFO - PROCESS | 16716 | __metrics Screen width/height:1600/1200 14:15:28 INFO - PROCESS | 16716 | colorDepth:24 14:15:28 INFO - PROCESS | 16716 | Browser inner width/height: 1024/697 14:15:28 INFO - PROCESS | 16716 | __metrics 14:15:29 INFO - PROCESS | 16716 | 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" 14:15:29 INFO - PROCESS | 16716 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:15:30 INFO - PROCESS | 16716 | console.error: PushService: 14:15:30 INFO - PROCESS | 16716 | stateChangeProcessEnqueue: Error transitioning state 14:15:30 INFO - PROCESS | 16716 | UnknownError 14:15:30 INFO - TEST-INFO | 16716: exit 0 14:15:30 INFO - Browser initialized. 14:15:30 INFO - Running cycle 1/1 for dromaeo_css test... 14:15:30 INFO - TEST-INFO | started process 16798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE3m9CS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:15:43 INFO - PROCESS | 16798 | RSS: Main: 181186560 14:15:43 INFO - PROCESS | 16798 | 14:16:34 INFO - PROCESS | 16798 | 1472850994398 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] 14:18:47 INFO - PROCESS | 16798 | Cycle 1(1): loaded http://localhost:39792/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39792/tests/dromaeo/cssquery-ext.html) 14:18:48 INFO - PROCESS | 16798 | RSS: Main: 287846400 14:18:48 INFO - PROCESS | 16798 | 14:21:51 INFO - PROCESS | 16798 | Cycle 1(1): loaded http://localhost:39792/tests/dromaeo/cssquery-ext.html (next: http://localhost:39792/tests/dromaeo/cssquery-jquery.html) 14:21:51 INFO - PROCESS | 16798 | RSS: Main: 273051648 14:21:51 INFO - PROCESS | 16798 | 14:24:54 INFO - PROCESS | 16798 | Cycle 1(1): loaded http://localhost:39792/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39792/tests/dromaeo/cssquery-mootools.html) 14:24:54 INFO - PROCESS | 16798 | RSS: Main: 218071040 14:24:54 INFO - PROCESS | 16798 | 14:27:57 INFO - PROCESS | 16798 | Cycle 1(1): loaded http://localhost:39792/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39792/tests/dromaeo/cssquery-prototype.html) 14:27:57 INFO - PROCESS | 16798 | RSS: Main: 218238976 14:27:57 INFO - PROCESS | 16798 | 14:31:00 INFO - PROCESS | 16798 | Cycle 1(1): loaded http://localhost:39792/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39792/tests/dromaeo/cssquery-yui.html) 14:31:01 INFO - PROCESS | 16798 | RSS: Main: 218714112 14:31:01 INFO - PROCESS | 16798 | 14:34:04 INFO - PROCESS | 16798 | Cycle 1(1): loaded http://localhost:39792/tests/dromaeo/cssquery-yui.html (next: http://localhost:39792/tests/dromaeo/cssquery-dojo.html) 14:34:04 INFO - PROCESS | 16798 | RSS: Main: 309669888 14:34:04 INFO - PROCESS | 16798 | 14:34:04 INFO - PROCESS | 16798 | __start_tp_report 14:34:04 INFO - PROCESS | 16798 | _x_x_mozilla_page_load 14:34:04 INFO - PROCESS | 16798 | _x_x_mozilla_page_load_details 14:34:04 INFO - PROCESS | 16798 | |i|pagename|runs| 14:34:04 INFO - PROCESS | 16798 | |0;dojo.html;2544.770970612645;2565.730598287181;2582.7675509204173;2587.275562842404;2612.581986882099;4534.50120486747;4577.840224009245;4603.7928293226805;4693.460252071009;4742.69172503787;4627.23650597651;4677.883052923678;4711.623070154388;4728.976355118229;4738.502457242001;4224.683148763839;4255.489341279051;4329.1558146161515;4379.27741922584;4462.97768511157;4381;4419.160359531695;4444;4468.19572476954;4476.55234476553;4193.391958166048;4227.8308867645255;4267.210566045292;4304.246756817544;4319.373690814846;4267.509236437819;4274.487061552602;4279.935800962988;4330.133973205371;4345;4303.074838909618;4309.82760689572;4340.65274778017;4357.7385356878685;4376.715513491645;4562.680612357136;4607.654425918069;4680.906381872377;4717.693349932243;4723.456802467692;4998.7250701211415;5032.345795046657;5036.169032109698;5037.345145131146;5095.210242412395;5049.823256186052;5054.898902021939;5058.949410505885;5079.314292570492;5086.542211200973;4565.863024109282;4677.204875171229;4701.764911754399;4724.787384567669;4734.621230301567;5131.153359695683;5139.511746384088;5155.355580552431;5200.115980283361;5212.270282160501;4936.802527898843;4942.061008408391;4945.431275403303;4951.282064100686;4992.8002879885125;4824.734639594786;4976.154053810861;5029.270755740397;5031;5037.395512538519;4994.625403094709;4995.225740010304;4999.550040496373;5032.194848824171;5034.798608055637;4955.1823949048;4964.304997300381;4968.527989840959;4971.801127954914;5029.949700503022;4047.0287131088917;4095.7542547447247;4150.501939767248;4183.7324545584825;4238.936415953764;3660.524131862841;3680.77915325076;3724.981375093107;3761.7366784324836;3788.583255841855;4396.3625274335045;4398.56014398564;4402.581754733295;4404.559544045634;4459.397981272552;4907.460179380265;5082.923756143661;5091;5099.898002039939;5168.664036837668;4440.888977775581;4454.977725111418;4462.866114016585;4512.751798651106;4517.570830771071;4582.908341833145;4583.472900616472;4586.174488592019;4619.607333376701;4631.467381251132;4594.494605593449;4736.928946065743;4823.807047718193;4827.686200396963;4839.177339852304;5068.391792984866;5092.6435149539175;5112.3865136183895;5161.483851614808;5168.664036837594;4807.399075115611;4820.975895120502;4821.349117869043;4825.155597770447;4885.340479035285;4831.9275210872565;4941.65408421407;4979.925301120558;5039.5968322534845;5096.490350964874;5037.7733002014265;5081.695098294114;5081.822136225214;5118.104331742004;5123.590112791042;4930.408350997904;4943.530364615356;4945.134601444661;4950.480199578992;5005.199168133081;4797.088553174885;4921.753912304442;4934.037862616899;4944.851654450372;5000.224965130411;4886.755662216804;4907.730074845775;4925.729084900365;4960.206366981266;4972.254161875748;5002.674826136289;5017.974910125426;5020.196768517019;5024.145895197752;5086.440491545853;4651;4684.156851766715;4849.660523763303;4857.514248575256;4917.778699958439 14:34:04 INFO - PROCESS | 16798 | |1;ext.html;566.640183483488;569.9088145896658;578.6932925549457;582.289606679851;584.1908956095806;27382.452350952968;37991.53055051423;39513.40729889054;39701.60298397015;42748.358774618326;39982;40193;40392;40411;40484.797576012155;7152.499325047249;7511.474196806212;7682.807929801744;7687.577183254919;7698.384129269673;7119.857602847966;7352.04423424954;7355.2644735526555;9609.375390599624;9886.456244906527;9981.700548983506;10032.799344013152;10034.147097496721;10043.296969212159;10049.145822605087;9857.359271647356;9879.654212102541;9917.90082099177;9930.354526955725;9930.45382503962;9698.75753106178;9771.902280977241;9773.12041916231;9774.071463210983;9776.217902567778;37579.62420375816;37775.244495110215;37876;37889.621103788886;37890.621093788985;2644.867756612162;2893.8263704177607;2968.109567129874;2969.6436427628823;3109.689031096872;27525.862370688217;28414;28771.56842647362;29003.12990610285;29583.40833183346;3210.357928414303;3272.132884785534;3303.240254741423;3328.5340052392685;3363.4450315698127;257528;257536;258613;258622;258813.70593147102;30711.539326909668;31941.201469962973;48772.51227487751;49065.75467122713;49170.26244606334;32907;33109.66890331066;33176.3364732704;33182.336353273284;33212;13190.670233244246;13351.399187036606;13354.198748075147;13354.93322533381;13361;10781.407022613832;10838.67483975482;10863.728406789736;10871.130309575216;10889.83665245022;7165.534240274365;7342.706291748377;7350.926490735131;7448.255174482617;7542.963399882001;2992;3039.6048513693077;3062.1579065757096;3063.892763753258;3086.0896035669084;798.4769975665948;807.7940125268136;922.3912217936264;943.7353945712778;982.6658935961807;26581;27684.446311073665;27924.58113128305;27952.30119247035;28060.579091313648;885.1104639836923;932.0586207929904;949.5726922884592;953.537534295866;961.2790407194605;14145.363458644386;14155.787663185061;14643.56069317922;14869.851301487062;14915.627109322137;400315;403015;404208;404589;404642;46766;47187.29219061717;47238;47262;47273.054538909026;1075.8063548561177;1110.189561620022;1130.5082289204222;1131.9434028298551;1135.4039129456935;25257.873710631327;26225.475490490466;26739.33151671224;27211.183664490098;27306.590401144396;41005.58994410137;41297.1740565181;41359.793201033805;41367.793161034;41414.792926035174;265116;266185;266425;266603;267354;21221.78778212198;21432.678509822053;21605;24414.145504907243;24987.500249994533;39148.41277380899;39277.41083883687;39485.210295793346;39638.801805990784;40108.79945600253;33831.4925276126;33938.49092263568;34461.310773784884;34479.827600861834;34857;33671.32657346888;34129.48805767965;34167.82916085404;34409.483857742656;35144.824275878455;33826.83086584551;34186.316273674885;34446.31107377889;34793.826030869684;34963.77626783152;29235.85382073076;31171;31312.373752525276;31517;31627.841860790548;24268.393290167885;24334.26997190087;24374.634380484662;24800.50398991974;24885.377865553506 14:34:04 INFO - PROCESS | 16798 | |2;jquery.html;359.34778377245317;364.38964734070436;368.2910397484841;378.68758274423607;382.26414152755956;15583.532494025183;16263.186840657963;17176.484705458824;17332.566685832862;17336.219870105844;16453.753193702105;16623.251953662086;16828.915855420735;16923.153842307896;16951.57621059471;4940.851774446773;5210.42685304618;5216.504432078947;5216.530512253897;5219.347581552306;3646.2342907989355;3848.9807550962205;3853.7880416577077;3910.296146693594;5101.515356041189;6100.816975490742;6219.973704338801;6230.96884515579;6231.345708700589;6233.7818176363835;5999.400059994009;6188.8762224755255;6206.968965155168;6215.223097112861;6219.906701399483;5465.125579907235;5471.945280547184;5475.397706252309;5476.205950137208;5476.288082549283;20355.69466458004;20435.897820510952;20995.370138895858;21010.789892101035;21067.578648426945;1691.585561537419;1921.5484361175113;1935.0614951748391;2025.3215172917091;2445.8410203336725;8958.507282099481;9172.036936121678;11143.498542565603;12442.19125756832;12458.937705311506;1704.514213449161;1743.5292471032876;1748.4230204032638;1757.0599729144974;1760.3310741918117;70243.29756702419;70324.64837675779;71031;71182.64408677975;71954;9089.95455022734;9268.25853931684;9277.489738064336;10097.545610447547;10303.639372621923;14175.574732758034;14176.85823141776;14188.219647919257;14204.28978551089;14215.85784142166;7346.669399877019;7496.475246732676;7565.394768418513;7743.4966727162555;7762.534247945141;7171.677274522659;7179.461540384492;7431.85136297271;7441.962790186014;7453.291937265951;4264.296391095435;4376.256036473807;4400.889977750582;4475.910481790411;4516.593506584358;1618.8623966962705;1715.2110029386372;1754.7280171573427;1786.6605344984412;1833.5874428253803;675.7432175773175;800.5076877720277;854.9016863060828;855.5978690015683;876.8860048193694;16740.330386784637;16756.16219189036;17554;17610.29558817633;17874;800.8198155414985;814.3729328417204;865.1996902864825;871.8387098386819;922.5433410461865;9529.90470095304;9936.50317484123;9990.900090999143;10001.899981000097;10042.447665378328;385243;390128;392641;393516;395037;49989;60470.09294860493;78765.60617196992;81756;82709;865.8874346334936;878.1043335797451;883.9513826739591;891.7681402835179;894.6868595991351;15086.849131508545;15210.859185560907;15792.289346979183;15817.68364632724;16156.757648635516;37361.4395784058;37861.43207851939;38656.2268754629;39000.41499377568;39357.409638854864;50365.49634503754;52882.735586321825;53382;54185;54753;7281.162666293444;7313.378362839218;7566.697332106654;7691.57696326685;7881.172476889844;6911.723531058701;7753.108392534705;11479.713007174887;11823.290602563873;12674.493020279455;9464.432134071978;9663.855042174513;9794.461304628314;10284.228682848667;10859.83710244331;9868.210543156387;10443.68668939933;10469.371837689763;10516.842247366449;10620.309679870783;9597.664081757104;9792.629031935392;10335.328203666737;10754.83867742;11105.555777768799;7500.62496875165;7621.733239336597;7639.121501027453;7643.656035478528;7911.683532658629;9719.9028009719;10405.84391234117;10714.785704286027;10810.621628242974;11068.944655276671 14:34:04 INFO - PROCESS | 16798 | |3;mootools.html;1315.3883444198445;1358.8641135886412;1371.8833899118574;1606.8071831380237;1644.8437398447143;6758.594484330932;7422.777316680495;7518.248175182493;7972.162922893092;8009.719659811908;7489.887651685229;7756.379489640829;7791.18192589777;7803.18066603007;7812.843743125134;2153.956920861578;2167.6531754919215;2175.053851574562;2176.227439259064;2187.704659870913;1833.9174737136793;2096.224396973122;2130.5845360154776;2164.437246315961;2175.3800166952424;2156.428546435196;2169.739631244253;2183.2031308572414;2191.2659259148204;2197.7582465928813;2105;2113.2075471698113;2172.663237198237;2175.510510135223;2176.0425412818468;2097.674860396641;2115.386537904021;2117.95764084719;2130.561870737246;2130.7762684918016;7980;8027.076886158108;8041.316488098519;8054.838903221903;8056.516609003478;4407.559244075599;4466.106778644252;4525.637948964075;4527.637788976874;4545;2920.0509834303934;2967.6735559088484;3054.129573071664;3060.816351018924;3075.4310452566347;924.1359329027381;958.2669258017622;958.6692591056144;958.942463452195;976.511744127936;10656.20078494116;10720.624778132727;10724.892751072468;10746.838797418044;10749.892501074968;4142.109446469024;4261.637760790306;4355.62977146946;4362.367456718758;4367.170237654899;9189.586468608928;9194.402363846328;9201.539923003824;9204.171624553823;9204.309676774135;4474.888127796766;4510.932336014962;4511.954880451219;4522.462362796665;4525.818967241339;3997.420374045805;4110.671146308348;4115.032967252693;4123.154753275571;4123.9175216495505;3560.092176494977;3627.510286111341;3665.2303016366327;3684.8811933138554;3693.575238847567;1098.1215027977746;1168.4333098447246;1182.5269892043252;1195.4441184849086;1229.538922903911;711.3100292716057;840.2521755637488;849.197508354599;850.6469815026818;858.4720396955827;5295.205719142159;5372.597055220874;5508.669479831223;5582;5593.888122237532;791.133708589094;819.8975128108987;831.1522247307712;856.8971723393232;873.1225118755737;3758.1919887224376;3822.636849499293;3844.2888065707934;3863.517060367454;3975.026118600961;9167.908320916838;9466.05339466048;9654.420734755937;9721.513924303756;9763.707088787347;9652.372595781251;9658.517074146404;9662.71011869645;9669.081437263449;9676.90323096774;6863.347981941807;7091.716331346792;7119.75080872167;7147.2852714728115;7156.713731450684;5363.758630861698;5388.164834450667;5416;5582.525485333792;5692.971535142297;8792.824143517222;8842.115788421364;8972.19250267479;9040.728778136667;9065.909340906506;9035.954820225857;9063.320250981335;9141.497217653094;9165.816683666422;9228.538573071453;6792.456603471809;6904.067950826574;6908.585484870924;6908.723651054102;6912.861742765016;7298.2701729826595;7381.704731810667;7445.9627701861145;7446.7021319146625;7461.141968673672;6620.404163625297;6738.124043874265;6816.352446517573;6845.315468453115;7017.754378596725;6644.800655980328;6645.102911107132;6657.300983396867;6672.599644021374;6699.9665001674675;6323.36766323364;6413.7113829876835;6466.385693359123;6467.3209313023335;6481.287058423475;4582.587567118975;4647.16351056813;4664.230401983635;4670.6263498919325;4761.6429867214565;4563.543645635543;4609.078184363074;4646.140464014168;4662.883427914329;4714.22215334466 14:34:04 INFO - PROCESS | 16798 | |4;prototype.html;291.71994884910487;296.83673979311374;298.6401386329473;305.6286611766703;309.1205520294761;4760.690555113915;4765.618750499961;4767.666263361566;4796.184648609736;4817.8072877084915;4716.811327546894;4716.952830471694;4720.268358404444;4722.417989973363;4727.8818029549275;3782.0922978485105;3791.6397942195586;3791.7345785795005;3799.8670046548445;3799.905002374935;3485.6862882340583;3822.7706337619693;3823.5985221551755;3830.731848770587;3837.0982819037645;3666.5600127984544;3709.9039042940653;3712;3724.3854763963914;3729.1236559408653;3678.779273243614;3688.6311368863167;3690.612485688991;3692.981535092334;3714.53568303962;3050.283183451887;3122.5324097674056;3240.3636163737397;3241.5785947826867;3243.562119113913;4621.445426548836;4626.9074618507775;4636.211843986531;4649.976750116228;4655.88360290992;4180.47744031996;4181.289180839264;4185.560516145822;4200.264953633133;4204.831806727727;4625.866662667668;4682.41469816273;4893.559579637849;4903.460619331906;4960.90078198434;3387.5596172497662;3397.7621566490357;3405.540252065989;3422.9315413691834;3424.8116353600544;5119.539241468286;5157.008934817797;5158.9484105158845;5174.146265866128;5194.467632048555;3428.405791307004;3602.1534939289245;3622.166901612644;3626;3630.636936306348;3634.4184930411006;3656.3784156693428;3662.1210909381557;3665.8086122010454;3667.688246499024;4166.812493437803;4185.058361868555;4185.618745813874;4186.91626167475;4196.244675958295;4940.777665005084;4951.430585482715;4959.801607935642;4961.4046314441775;4967.875803104951;1234.216272666863;1252.8621851596317;1262.810578413227;1266.2402558464848;1271.9618411447486;794.7337641889916;809.6073404398862;817.2195553246635;822.1490757066407;829.1335554345724;3975.860844870416;4015.297322968469;4015.678745700337;4023.3763766615634;4027.81874815634;4526.70375660478;4542.704724192917;4544.863654090383;4588.403507543998;4607.44710634726;4036.192761447722;4037.232925744158;4038.788363491;4046.656034237064;4050.3924411338535;2348.09804058713;2428.7206971198184;2428.7571242875924;2445.400876785199;2449.4856080223;4347.934780978288;4626.154914727485;4668.883277918079;4822.156122678517;4843.418789745183;5206.193040078794;5217.713025783542;5224.660397074178;5250.842474725764;5255.947440525622;4846.224604063333;4851.078295123915;4854.208829922809;4873.878153046131;4874.683145595525;4991.301217829579;5128.846009647948;5148.58811295103;5152.3044389007;5163.8192663256605;4986.805805445592;5058.747062646927;5061.974690126526;5067.923981140212;5073.974630126826;4699.5770380664535;4833.371661683958;4834.540718631724;4847.684900481458;4849.224124140121;3606.3688854450893;3608.80151591665;3615.6203598621764;3628;3631.1648320885815;5099.898002040012;5101.744912754273;5106.80824484697;5113.53978141969;5123.487651234996;4953.854302517855;4954.529319714621;4970.378702662168;4988.326575912351;5014.395393474053;4738.265568836836;4946.925796113133;4963.503649635008;4969.975150124226;4970.304157418037;4893.632977526629;4895.779689913891;4896.559309662148;4904.803807847647;4975.6019518437715;5048.974755126201;5051.166557518115;5060.304797892747;5061.31672224245;5072.858606813437;4602.516735742699;4824.807007719793;4888.095702295087;4888.828890988798;4906.852794416173 14:34:04 INFO - PROCESS | 16798 | |5;yui.html;606.73910218606;701.2776839854952;718.1740997852472;739.1610522057463;743.3867059675769;12491.375431228436;12947.741045179091;13029.73940521189;13057.73884522309;13159.605211843647;12999;13156.473741050371;13157.276349800757;13163.934180329108;13179.604611861636;588.364566268429;716.0691101567967;717.429643433469;738.401894465482;743.1453828097677;744.0401881572792;744.94040476762;747.1482509938675;747.5701471653794;748.2293237964905;782.636074225485;783.6238605469379;783.8471498057881;784.3411534311177;784.3881772217679;617.7745123030085;747.2527472527472;767.2136060537938;768.4198430185174;774.573984308628;563.7660370946094;566.7449647658528;566.9433056694297;567.013396689761;567.3645517020922;12522.436490357955;12550.435230414654;12563.623091307276;12572.874271257262;12575.874241257561;12577.182483138567;13004.60986170407;13283.335833208397;13361.198328100345;13679.726405471934;11859.584914528037;12071.336076515789;12102.213356131822;12283.447244874002;12515.874841251562;4031.173609410064;4032.858849940238;4043.9595604043875;4099.077707515815;4154.148399578079;61340;61348.07977880335;63635;65569.67215163942;65790.67104664494;10180.134688551409;10273.691789246335;10307.484625768682;10449.634262800766;10846.349219046724;19217.80782192188;19223.807761922482;19233.80766192348;19294.22823087089;19356;6872.896906546306;6896.482763792736;7004.205113896748;7160.355567998801;7194.172670143001;3652.7808331500196;3664.450332450154;3669.192777588926;3678.117251859588;3783.2244389900006;2771.5426954552677;2875.0368626509935;3156.9684303156673;3362.815045172539;3364.62989071202;557.1336571631152;566.1620801214226;569.1462805791313;570.2814453788174;572.0475408444976;520.8723862653674;588.1060787602905;616.7286393986632;618.1839971237923;624.2945471617135;7743.5353878767455;7775.92224077752;7977.641006154737;8074;8201.917980820235;477.7563442644207;514.2337916504382;522.5062316111314;544.238066706606;565.8019693107461;3772.641599048086;3817.408301713239;3952.7035472339116;3990.700697447645;4012.959870401317;77799.22200778034;79428.60285698535;99875;109024.4548777251;109158;89508.5524572373;92175;92524.53737731268;92815.53592231996;93380;47376.64924072691;81120.59439702882;81408.59295703602;81681.18318816855;81814.59092704498;7478.775636730907;7625.3137217648455;7641.541507509567;7676.232376762502;7713.845723085619;45483.31775023443;45785.313220301054;46903.76548117238;48112.518874810805;49158;60033;66734;67446.26706729984;67746.66126669335;70471;8875.378723489293;9087.273418050549;9117.817643647222;9300.255979521757;9609;9795.51022448889;9837;10121.949390253001;11020.944895275794;11910.880891191324;10547.683569492927;10581.62964296246;10698.358098514114;10882;10989.835152472879;9707.369021013612;9888.703338899844;10002.849957250794;10027.097561219525;10340.482975851328;9644.807103858024;9715.319927605;10007.449590272605;10131.189504839447;10442.843357349493;8907.866382004404;9176.541172941459;9341.590319533458;9476.763080923032;9638.807223855623;8103.513789172668;8120.14738452454;8412.831743365221;8422.789430264293;8458.28104611115 14:34:04 INFO - PROCESS | 16798 | __end_tp_report 14:34:04 INFO - PROCESS | 16798 | __start_cc_report 14:34:04 INFO - PROCESS | 16798 | _x_x_mozilla_cycle_collect,1012 14:34:04 INFO - PROCESS | 16798 | __end_cc_report 14:34:04 INFO - PROCESS | 16798 | __startTimestamp1472852044736__endTimestamp 14:34:04 INFO - PROCESS | 16798 | 14:34:04 INFO - PROCESS | 16798 | ------- Summary: start ------- 14:34:04 INFO - PROCESS | 16798 | Number of tests: 6 14:34:04 INFO - PROCESS | 16798 | 14:34:04 INFO - PROCESS | 16798 | [#0] dojo.html Cycles:165 Average:4665.07 Median:4821.35 stddev:502.64 (10.4%) stddev-sans-first:475.86 14:34:04 INFO - PROCESS | 16798 | Values: 2544.8 2565.7 2582.8 2587.3 2612.6 4534.5 4577.8 4603.8 4693.5 4742.7 4627.2 4677.9 4711.6 4729.0 4738.5 4224.7 4255.5 4329.2 4379.3 4463.0 4381.0 4419.2 4444.0 4468.2 4476.6 4193.4 4227.8 4267.2 4304.2 4319.4 4267.5 4274.5 4279.9 4330.1 4345.0 4303.1 4309.8 4340.7 4357.7 4376.7 4562.7 4607.7 4680.9 4717.7 4723.5 4998.7 5032.3 5036.2 5037.3 5095.2 5049.8 5054.9 5058.9 5079.3 5086.5 4565.9 4677.2 4701.8 4724.8 4734.6 5131.2 5139.5 5155.4 5200.1 5212.3 4936.8 4942.1 4945.4 4951.3 4992.8 4824.7 4976.2 5029.3 5031.0 5037.4 4994.6 4995.2 4999.6 5032.2 5034.8 4955.2 4964.3 4968.5 4971.8 5029.9 4047.0 4095.8 4150.5 4183.7 4238.9 3660.5 3680.8 3725.0 3761.7 3788.6 4396.4 4398.6 4402.6 4404.6 4459.4 4907.5 5082.9 5091.0 5099.9 5168.7 4440.9 4455.0 4462.9 4512.8 4517.6 4582.9 4583.5 4586.2 4619.6 4631.5 4594.5 4736.9 4823.8 4827.7 4839.2 5068.4 5092.6 5112.4 5161.5 5168.7 4807.4 4821.0 4821.3 4825.2 4885.3 4831.9 4941.7 4979.9 5039.6 5096.5 5037.8 5081.7 5081.8 5118.1 5123.6 4930.4 4943.5 4945.1 4950.5 5005.2 4797.1 4921.8 4934.0 4944.9 5000.2 4886.8 4907.7 4925.7 4960.2 4972.3 5002.7 5018.0 5020.2 5024.1 5086.4 4651.0 4684.2 4849.7 4857.5 4917.8 14:34:04 INFO - PROCESS | 16798 | 14:34:04 INFO - PROCESS | 16798 | [#1] ext.html Cycles:180 Average:44861.37 Median:34033.99 stddev:83514.46 (245.4%) stddev-sans-first:83682.52 14:34:04 INFO - PROCESS | 16798 | Values: 566.6 569.9 578.7 582.3 584.2 27382.5 37991.5 39513.4 39701.6 42748.4 39982.0 40193.0 40392.0 40411.0 40484.8 7152.5 7511.5 7682.8 7687.6 7698.4 7119.9 7352.0 7355.3 9609.4 9886.5 9981.7 10032.8 10034.1 10043.3 10049.1 9857.4 9879.7 9917.9 9930.4 9930.5 9698.8 9771.9 9773.1 9774.1 9776.2 37579.6 37775.2 37876.0 37889.6 37890.6 2644.9 2893.8 2968.1 2969.6 3109.7 27525.9 28414.0 28771.6 29003.1 29583.4 3210.4 3272.1 3303.2 3328.5 3363.4 257528.0 257536.0 258613.0 258622.0 258813.7 30711.5 31941.2 48772.5 49065.8 49170.3 32907.0 33109.7 33176.3 33182.3 33212.0 13190.7 13351.4 13354.2 13354.9 13361.0 10781.4 10838.7 10863.7 10871.1 10889.8 7165.5 7342.7 7350.9 7448.3 7543.0 2992.0 3039.6 3062.2 3063.9 3086.1 798.5 807.8 922.4 943.7 982.7 26581.0 27684.4 27924.6 27952.3 28060.6 885.1 932.1 949.6 953.5 961.3 14145.4 14155.8 14643.6 14869.9 14915.6 400315.0 403015.0 404208.0 404589.0 404642.0 46766.0 47187.3 47238.0 47262.0 47273.1 1075.8 1110.2 1130.5 1131.9 1135.4 25257.9 26225.5 26739.3 27211.2 27306.6 41005.6 41297.2 41359.8 41367.8 41414.8 265116.0 266185.0 266425.0 266603.0 267354.0 21221.8 21432.7 21605.0 24414.1 24987.5 39148.4 39277.4 39485.2 39638.8 40108.8 33831.5 33938.5 34461.3 34479.8 34857.0 33671.3 34129.5 34167.8 34409.5 35144.8 33826.8 34186.3 34446.3 34793.8 34963.8 29235.9 31171.0 31312.4 31517.0 31627.8 24268.4 24334.3 24374.6 24800.5 24885.4 14:34:04 INFO - PROCESS | 16798 | 14:34:04 INFO - PROCESS | 16798 | [#2] jquery.html Cycles:180 Average:24380.24 Median:4496.25 stddev:64566.51 (1436.0%) stddev-sans-first:64722.45 14:34:04 INFO - PROCESS | 16798 | Values: 359.3 364.4 368.3 378.7 382.3 15583.5 16263.2 17176.5 17332.6 17336.2 16453.8 16623.3 16828.9 16923.2 16951.6 4940.9 5210.4 5216.5 5216.5 5219.3 3646.2 3849.0 3853.8 3910.3 5101.5 6100.8 6220.0 6231.0 6231.3 6233.8 5999.4 6188.9 6207.0 6215.2 6219.9 5465.1 5471.9 5475.4 5476.2 5476.3 20355.7 20435.9 20995.4 21010.8 21067.6 1691.6 1921.5 1935.1 2025.3 2445.8 8958.5 9172.0 11143.5 12442.2 12458.9 1704.5 1743.5 1748.4 1757.1 1760.3 70243.3 70324.6 71031.0 71182.6 71954.0 9090.0 9268.3 9277.5 10097.5 10303.6 14175.6 14176.9 14188.2 14204.3 14215.9 7346.7 7496.5 7565.4 7743.5 7762.5 7171.7 7179.5 7431.9 7442.0 7453.3 4264.3 4376.3 4400.9 4475.9 4516.6 1618.9 1715.2 1754.7 1786.7 1833.6 675.7 800.5 854.9 855.6 876.9 16740.3 16756.2 17554.0 17610.3 17874.0 800.8 814.4 865.2 871.8 922.5 9529.9 9936.5 9990.9 10001.9 10042.4 385243.0 390128.0 392641.0 393516.0 395037.0 49989.0 60470.1 78765.6 81756.0 82709.0 865.9 878.1 884.0 891.8 894.7 15086.8 15210.9 15792.3 15817.7 16156.8 37361.4 37861.4 38656.2 39000.4 39357.4 50365.5 52882.7 53382.0 54185.0 54753.0 7281.2 7313.4 7566.7 7691.6 7881.2 6911.7 7753.1 11479.7 11823.3 12674.5 9464.4 9663.9 9794.5 10284.2 10859.8 9868.2 10443.7 10469.4 10516.8 10620.3 9597.7 9792.6 10335.3 10754.8 11105.6 7500.6 7621.7 7639.1 7643.7 7911.7 9719.9 10405.8 10714.8 10810.6 11068.9 14:34:04 INFO - PROCESS | 16798 | 14:34:04 INFO - PROCESS | 16798 | [#3] mootools.html Cycles:180 Average:5163.73 Median:5545.33 stddev:2887.79 (52.1%) stddev-sans-first:2881.41 14:34:04 INFO - PROCESS | 16798 | Values: 1315.4 1358.9 1371.9 1606.8 1644.8 6758.6 7422.8 7518.2 7972.2 8009.7 7489.9 7756.4 7791.2 7803.2 7812.8 2154.0 2167.7 2175.1 2176.2 2187.7 1833.9 2096.2 2130.6 2164.4 2175.4 2156.4 2169.7 2183.2 2191.3 2197.8 2105.0 2113.2 2172.7 2175.5 2176.0 2097.7 2115.4 2118.0 2130.6 2130.8 7980.0 8027.1 8041.3 8054.8 8056.5 4407.6 4466.1 4525.6 4527.6 4545.0 2920.1 2967.7 3054.1 3060.8 3075.4 924.1 958.3 958.7 958.9 976.5 10656.2 10720.6 10724.9 10746.8 10749.9 4142.1 4261.6 4355.6 4362.4 4367.2 9189.6 9194.4 9201.5 9204.2 9204.3 4474.9 4510.9 4512.0 4522.5 4525.8 3997.4 4110.7 4115.0 4123.2 4123.9 3560.1 3627.5 3665.2 3684.9 3693.6 1098.1 1168.4 1182.5 1195.4 1229.5 711.3 840.3 849.2 850.6 858.5 5295.2 5372.6 5508.7 5582.0 5593.9 791.1 819.9 831.2 856.9 873.1 3758.2 3822.6 3844.3 3863.5 3975.0 9167.9 9466.1 9654.4 9721.5 9763.7 9652.4 9658.5 9662.7 9669.1 9676.9 6863.3 7091.7 7119.8 7147.3 7156.7 5363.8 5388.2 5416.0 5582.5 5693.0 8792.8 8842.1 8972.2 9040.7 9065.9 9036.0 9063.3 9141.5 9165.8 9228.5 6792.5 6904.1 6908.6 6908.7 6912.9 7298.3 7381.7 7446.0 7446.7 7461.1 6620.4 6738.1 6816.4 6845.3 7017.8 6644.8 6645.1 6657.3 6672.6 6700.0 6323.4 6413.7 6466.4 6467.3 6481.3 4582.6 4647.2 4664.2 4670.6 4761.6 4563.5 4609.1 4646.1 4662.9 4714.2 14:34:04 INFO - PROCESS | 16798 | 14:34:04 INFO - PROCESS | 16798 | [#4] prototype.html Cycles:180 Average:4077.30 Median:4631.56 stddev:1201.78 (25.9%) stddev-sans-first:1171.08 14:34:04 INFO - PROCESS | 16798 | Values: 291.7 296.8 298.6 305.6 309.1 4760.7 4765.6 4767.7 4796.2 4817.8 4716.8 4717.0 4720.3 4722.4 4727.9 3782.1 3791.6 3791.7 3799.9 3799.9 3485.7 3822.8 3823.6 3830.7 3837.1 3666.6 3709.9 3712.0 3724.4 3729.1 3678.8 3688.6 3690.6 3693.0 3714.5 3050.3 3122.5 3240.4 3241.6 3243.6 4621.4 4626.9 4636.2 4650.0 4655.9 4180.5 4181.3 4185.6 4200.3 4204.8 4625.9 4682.4 4893.6 4903.5 4960.9 3387.6 3397.8 3405.5 3422.9 3424.8 5119.5 5157.0 5158.9 5174.1 5194.5 3428.4 3602.2 3622.2 3626.0 3630.6 3634.4 3656.4 3662.1 3665.8 3667.7 4166.8 4185.1 4185.6 4186.9 4196.2 4940.8 4951.4 4959.8 4961.4 4967.9 1234.2 1252.9 1262.8 1266.2 1272.0 794.7 809.6 817.2 822.1 829.1 3975.9 4015.3 4015.7 4023.4 4027.8 4526.7 4542.7 4544.9 4588.4 4607.4 4036.2 4037.2 4038.8 4046.7 4050.4 2348.1 2428.7 2428.8 2445.4 2449.5 4347.9 4626.2 4668.9 4822.2 4843.4 5206.2 5217.7 5224.7 5250.8 5255.9 4846.2 4851.1 4854.2 4873.9 4874.7 4991.3 5128.8 5148.6 5152.3 5163.8 4986.8 5058.7 5062.0 5067.9 5074.0 4699.6 4833.4 4834.5 4847.7 4849.2 3606.4 3608.8 3615.6 3628.0 3631.2 5099.9 5101.7 5106.8 5113.5 5123.5 4953.9 4954.5 4970.4 4988.3 5014.4 4738.3 4946.9 4963.5 4970.0 4970.3 4893.6 4895.8 4896.6 4904.8 4975.6 5049.0 5051.2 5060.3 5061.3 5072.9 4602.5 4824.8 4888.1 4888.8 4906.9 14:34:04 INFO - PROCESS | 16798 | 14:34:04 INFO - PROCESS | 16798 | [#5] yui.html Cycles:180 Average:17887.56 Median:569.71 stddev:26342.13 (4623.7%) stddev-sans-first:26384.07 14:34:04 INFO - PROCESS | 16798 | Values: 606.7 701.3 718.2 739.2 743.4 12491.4 12947.7 13029.7 13057.7 13159.6 12999.0 13156.5 13157.3 13163.9 13179.6 588.4 716.1 717.4 738.4 743.1 744.0 744.9 747.1 747.6 748.2 782.6 783.6 783.8 784.3 784.4 617.8 747.3 767.2 768.4 774.6 563.8 566.7 566.9 567.0 567.4 12522.4 12550.4 12563.6 12572.9 12575.9 12577.2 13004.6 13283.3 13361.2 13679.7 11859.6 12071.3 12102.2 12283.4 12515.9 4031.2 4032.9 4044.0 4099.1 4154.1 61340.0 61348.1 63635.0 65569.7 65790.7 10180.1 10273.7 10307.5 10449.6 10846.3 19217.8 19223.8 19233.8 19294.2 19356.0 6872.9 6896.5 7004.2 7160.4 7194.2 3652.8 3664.5 3669.2 3678.1 3783.2 2771.5 2875.0 3157.0 3362.8 3364.6 557.1 566.2 569.1 570.3 572.0 520.9 588.1 616.7 618.2 624.3 7743.5 7775.9 7977.6 8074.0 8201.9 477.8 514.2 522.5 544.2 565.8 3772.6 3817.4 3952.7 3990.7 4013.0 77799.2 79428.6 99875.0 109024.5 109158.0 89508.6 92175.0 92524.5 92815.5 93380.0 47376.6 81120.6 81408.6 81681.2 81814.6 7478.8 7625.3 7641.5 7676.2 7713.8 45483.3 45785.3 46903.8 48112.5 49158.0 60033.0 66734.0 67446.3 67746.7 70471.0 8875.4 9087.3 9117.8 9300.3 9609.0 9795.5 9837.0 10121.9 11020.9 11910.9 10547.7 10581.6 10698.4 10882.0 10989.8 9707.4 9888.7 10002.8 10027.1 10340.5 9644.8 9715.3 10007.4 10131.2 10442.8 8907.9 9176.5 9341.6 9476.8 9638.8 8103.5 8120.1 8412.8 8422.8 8458.3 14:34:04 INFO - PROCESS | 16798 | -------- Summary: end -------- 14:34:04 INFO - PROCESS | 16798 | 14:34:05 INFO - TEST-INFO | 16798: exit 0 14:34:05 INFO - TEST-OK | dromaeo_css | took 1121624ms 14:34:05 INFO - TEST-START | kraken 14:34:05 INFO - operating with platform_type : linux_ 14:34:05 INFO - Initialising browser for kraken test... 14:34:05 INFO - TEST-INFO | started process 17107 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg6wYjN/profile http://localhost:39792/getInfo.html) 14:34:10 INFO - PROCESS | 17107 | __metrics Screen width/height:1600/1200 14:34:10 INFO - PROCESS | 17107 | colorDepth:24 14:34:10 INFO - PROCESS | 17107 | Browser inner width/height: 1024/697 14:34:10 INFO - PROCESS | 17107 | __metrics 14:34:10 INFO - PROCESS | 17107 | 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" 14:34:10 INFO - PROCESS | 17107 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:34:11 INFO - PROCESS | 17107 | console.error: PushService: 14:34:11 INFO - PROCESS | 17107 | stateChangeProcessEnqueue: Error transitioning state 14:34:11 INFO - PROCESS | 17107 | UnknownError 14:34:12 INFO - TEST-INFO | 17107: exit 0 14:34:12 INFO - Browser initialized. 14:34:12 INFO - Running cycle 1/1 for kraken test... 14:34:12 INFO - TEST-INFO | started process 17190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg6wYjN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:34:24 INFO - PROCESS | 17190 | RSS: Main: 180731904 14:34:24 INFO - PROCESS | 17190 | 14:34:27 INFO - PROCESS | 17190 | Cycle 1(1): loaded http://localhost:39792/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39792/tests/kraken/driver.html?testName=audio-beat-detection) 14:34:28 INFO - PROCESS | 17190 | RSS: Main: 235347968 14:34:28 INFO - PROCESS | 17190 | 14:34:31 INFO - PROCESS | 17190 | Cycle 1(1): loaded http://localhost:39792/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39792/tests/kraken/driver.html?testName=audio-dft) 14:34:31 INFO - PROCESS | 17190 | RSS: Main: 224145408 14:34:31 INFO - PROCESS | 17190 | 14:34:34 INFO - PROCESS | 17190 | Cycle 1(1): loaded http://localhost:39792/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39792/tests/kraken/driver.html?testName=audio-fft) 14:34:35 INFO - PROCESS | 17190 | RSS: Main: 305369088 14:34:35 INFO - PROCESS | 17190 | 14:34:37 INFO - PROCESS | 17190 | Cycle 1(1): loaded http://localhost:39792/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39792/tests/kraken/driver.html?testName=audio-oscillator) 14:34:38 INFO - PROCESS | 17190 | RSS: Main: 215093248 14:34:38 INFO - PROCESS | 17190 | 14:34:40 INFO - PROCESS | 17190 | Cycle 1(1): loaded http://localhost:39792/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39792/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:34:41 INFO - PROCESS | 17190 | RSS: Main: 215293952 14:34:41 INFO - PROCESS | 17190 | 14:34:44 INFO - PROCESS | 17190 | Cycle 1(1): loaded http://localhost:39792/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39792/tests/kraken/driver.html?testName=imaging-darkroom) 14:34:44 INFO - PROCESS | 17190 | RSS: Main: 255365120 14:34:44 INFO - PROCESS | 17190 | 14:34:48 INFO - PROCESS | 17190 | Cycle 1(1): loaded http://localhost:39792/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39792/tests/kraken/driver.html?testName=imaging-desaturate) 14:34:49 INFO - PROCESS | 17190 | RSS: Main: 250126336 14:34:49 INFO - PROCESS | 17190 | 14:34:51 INFO - PROCESS | 17190 | Cycle 1(1): loaded http://localhost:39792/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39792/tests/kraken/driver.html?testName=json-parse-financial) 14:34:52 INFO - PROCESS | 17190 | RSS: Main: 253100032 14:34:52 INFO - PROCESS | 17190 | 14:34:54 INFO - PROCESS | 17190 | Cycle 1(1): loaded http://localhost:39792/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39792/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:34:54 INFO - PROCESS | 17190 | RSS: Main: 216326144 14:34:54 INFO - PROCESS | 17190 | 14:34:56 INFO - PROCESS | 17190 | Cycle 1(1): loaded http://localhost:39792/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39792/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:34:57 INFO - PROCESS | 17190 | RSS: Main: 224088064 14:34:57 INFO - PROCESS | 17190 | 14:34:59 INFO - PROCESS | 17190 | Cycle 1(1): loaded http://localhost:39792/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39792/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:35:00 INFO - PROCESS | 17190 | RSS: Main: 223055872 14:35:00 INFO - PROCESS | 17190 | 14:35:03 INFO - PROCESS | 17190 | Cycle 1(1): loaded http://localhost:39792/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39792/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:35:03 INFO - PROCESS | 17190 | RSS: Main: 224309248 14:35:03 INFO - PROCESS | 17190 | 14:35:06 INFO - PROCESS | 17190 | Cycle 1(1): loaded http://localhost:39792/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39792/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:35:07 INFO - PROCESS | 17190 | RSS: Main: 221880320 14:35:07 INFO - PROCESS | 17190 | 14:35:09 INFO - PROCESS | 17190 | Cycle 1(1): loaded http://localhost:39792/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39792/tests/kraken/driver.html?testName=ai-astar) 14:35:09 INFO - PROCESS | 17190 | RSS: Main: 272785408 14:35:09 INFO - PROCESS | 17190 | 14:35:09 INFO - PROCESS | 17190 | __start_tp_report 14:35:09 INFO - PROCESS | 17190 | _x_x_mozilla_page_load 14:35:09 INFO - PROCESS | 17190 | _x_x_mozilla_page_load_details 14:35:09 INFO - PROCESS | 17190 | |i|pagename|runs| 14:35:09 INFO - PROCESS | 17190 | |0;ai-astar;118;115;120;117;113;114;114;116;116;130 14:35:09 INFO - PROCESS | 17190 | |1;audio-beat-detection;160;128;153;191;125;144;154;123;183;123 14:35:09 INFO - PROCESS | 17190 | |2;audio-dft;163;165;162;161;161;163;166;164;164;163 14:35:09 INFO - PROCESS | 17190 | |3;audio-fft;76;76;76;167;80;76;77;77;160;76 14:35:09 INFO - PROCESS | 17190 | |4;audio-oscillator;84;86;158;84;84;84;149;83;83;137 14:35:09 INFO - PROCESS | 17190 | |5;imaging-gaussian-blur;117;117;116;116;117;116;118;117;117;117 14:35:09 INFO - PROCESS | 17190 | |6;imaging-darkroom;146;147;146;147;146;146;146;146;147;146 14:35:09 INFO - PROCESS | 17190 | |7;imaging-desaturate;94;95;96;95;94;95;95;95;95;94 14:35:09 INFO - PROCESS | 17190 | |8;json-parse-financial;68;67;68;65;67;69;68;78;65;65 14:35:09 INFO - PROCESS | 17190 | |9;json-stringify-tinderbox;65;65;65;66;68;66;66;67;67;67 14:35:09 INFO - PROCESS | 17190 | |10;stanford-crypto-aes;83;83;83;84;83;83;91;83;84;83 14:35:09 INFO - PROCESS | 17190 | |11;stanford-crypto-ccm;143;136;143;132;136;141;145;158;177;135 14:35:09 INFO - PROCESS | 17190 | |12;stanford-crypto-pbkdf2;178;180;179;181;179;179;183;181;179;189 14:35:09 INFO - PROCESS | 17190 | |13;stanford-crypto-sha256-iterative;70;71;72;69;69;70;69;74;70;72 14:35:09 INFO - PROCESS | 17190 | __end_tp_report 14:35:09 INFO - PROCESS | 17190 | __start_cc_report 14:35:09 INFO - PROCESS | 17190 | _x_x_mozilla_cycle_collect,1932 14:35:09 INFO - PROCESS | 17190 | __end_cc_report 14:35:09 INFO - PROCESS | 17190 | __startTimestamp1472852109570__endTimestamp 14:35:09 INFO - PROCESS | 17190 | 14:35:09 INFO - PROCESS | 17190 | ------- Summary: start ------- 14:35:09 INFO - PROCESS | 17190 | Number of tests: 14 14:35:09 INFO - PROCESS | 17190 | 14:35:09 INFO - PROCESS | 17190 | [#0] ai-astar Cycles:10 Average:117.30 Median:116.50 stddev:4.92 (4.2%) stddev-sans-first:5.21 14:35:09 INFO - PROCESS | 17190 | Values: 118.0 115.0 120.0 117.0 113.0 114.0 114.0 116.0 116.0 130.0 14:35:09 INFO - PROCESS | 17190 | 14:35:09 INFO - PROCESS | 17190 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:153.50 stddev:24.66 (16.1%) stddev-sans-first:25.79 14:35:09 INFO - PROCESS | 17190 | Values: 160.0 128.0 153.0 191.0 125.0 144.0 154.0 123.0 183.0 123.0 14:35:09 INFO - PROCESS | 17190 | 14:35:09 INFO - PROCESS | 17190 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:1.62 (1.0%) stddev-sans-first:1.72 14:35:09 INFO - PROCESS | 17190 | Values: 163.0 165.0 162.0 161.0 161.0 163.0 166.0 164.0 164.0 163.0 14:35:09 INFO - PROCESS | 17190 | 14:35:09 INFO - PROCESS | 17190 | [#3] audio-fft Cycles:10 Average:94.10 Median:76.00 stddev:36.63 (48.2%) stddev-sans-first:38.27 14:35:09 INFO - PROCESS | 17190 | Values: 76.0 76.0 76.0 167.0 80.0 76.0 77.0 77.0 160.0 76.0 14:35:09 INFO - PROCESS | 17190 | 14:35:09 INFO - PROCESS | 17190 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:84.00 stddev:31.32 (37.3%) stddev-sans-first:32.44 14:35:09 INFO - PROCESS | 17190 | Values: 84.0 86.0 158.0 84.0 84.0 84.0 149.0 83.0 83.0 137.0 14:35:09 INFO - PROCESS | 17190 | 14:35:09 INFO - PROCESS | 17190 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 14:35:09 INFO - PROCESS | 17190 | Values: 117.0 117.0 116.0 116.0 117.0 116.0 118.0 117.0 117.0 117.0 14:35:09 INFO - PROCESS | 17190 | 14:35:09 INFO - PROCESS | 17190 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 14:35:09 INFO - PROCESS | 17190 | Values: 146.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 14:35:09 INFO - PROCESS | 17190 | 14:35:09 INFO - PROCESS | 17190 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 14:35:09 INFO - PROCESS | 17190 | Values: 94.0 95.0 96.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 14:35:09 INFO - PROCESS | 17190 | 14:35:09 INFO - PROCESS | 17190 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:68.00 stddev:3.80 (5.6%) stddev-sans-first:4.03 14:35:09 INFO - PROCESS | 17190 | Values: 68.0 67.0 68.0 65.0 67.0 69.0 68.0 78.0 65.0 65.0 14:35:09 INFO - PROCESS | 17190 | 14:35:09 INFO - PROCESS | 17190 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.50 stddev:1.03 (1.6%) stddev-sans-first:1.00 14:35:09 INFO - PROCESS | 17190 | Values: 65.0 65.0 65.0 66.0 68.0 66.0 66.0 67.0 67.0 67.0 14:35:09 INFO - PROCESS | 17190 | 14:35:09 INFO - PROCESS | 17190 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:83.00 stddev:2.49 (3.0%) stddev-sans-first:2.62 14:35:09 INFO - PROCESS | 17190 | Values: 83.0 83.0 83.0 84.0 83.0 83.0 91.0 83.0 84.0 83.0 14:35:09 INFO - PROCESS | 17190 | 14:35:09 INFO - PROCESS | 17190 | [#11] stanford-crypto-ccm Cycles:10 Average:144.60 Median:143.00 stddev:13.53 (9.5%) stddev-sans-first:14.33 14:35:09 INFO - PROCESS | 17190 | Values: 143.0 136.0 143.0 132.0 136.0 141.0 145.0 158.0 177.0 135.0 14:35:09 INFO - PROCESS | 17190 | 14:35:09 INFO - PROCESS | 17190 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.80 Median:180.50 stddev:3.22 (1.8%) stddev-sans-first:3.26 14:35:09 INFO - PROCESS | 17190 | Values: 178.0 180.0 179.0 181.0 179.0 179.0 183.0 181.0 179.0 189.0 14:35:09 INFO - PROCESS | 17190 | 14:35:09 INFO - PROCESS | 17190 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.50 stddev:1.65 (2.3%) stddev-sans-first:1.73 14:35:09 INFO - PROCESS | 17190 | Values: 70.0 71.0 72.0 69.0 69.0 70.0 69.0 74.0 70.0 72.0 14:35:09 INFO - PROCESS | 17190 | -------- Summary: end -------- 14:35:09 INFO - PROCESS | 17190 | 14:35:10 INFO - TEST-INFO | 17190: exit 0 14:35:10 INFO - TEST-OK | kraken | took 65145ms 14:35:10 INFO - SUITE-END | took 1186s 14:35:11 INFO - Completed test suite (00:19:47) 14:35:11 INFO - javascript benchmark 14:35:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2544.770970612645, 2565.730598287181, 2582.7675509204173, 2587.275562842404, 2612.581986882099, 4534.50120486747, 4577.840224009245, 4603.7928293226805, 4693.460252071009, 4742.69172503787, 4627.23650597651, 4677.883052923678, 4711.623070154388, 4728.976355118229, 4738.502457242001, 4224.683148763839, 4255.489341279051, 4329.1558146161515, 4379.27741922584, 4462.97768511157, 4381.0, 4419.160359531695, 4444.0, 4468.19572476954, 4476.55234476553, 4193.391958166048, 4227.8308867645255, 4267.210566045292, 4304.246756817544, 4319.373690814846, 4267.509236437819, 4274.487061552602, 4279.935800962988, 4330.133973205371, 4345.0, 4303.074838909618, 4309.82760689572, 4340.65274778017, 4357.7385356878685, 4376.715513491645, 4562.680612357136, 4607.654425918069, 4680.906381872377, 4717.693349932243, 4723.456802467692, 4998.7250701211415, 5032.345795046657, 5036.169032109698, 5037.345145131146, 5095.210242412395, 5049.823256186052, 5054.898902021939, 5058.949410505885, 5079.314292570492, 5086.542211200973, 4565.863024109282, 4677.204875171229, 4701.764911754399, 4724.787384567669, 4734.621230301567, 5131.153359695683, 5139.511746384088, 5155.355580552431, 5200.115980283361, 5212.270282160501, 4936.802527898843, 4942.061008408391, 4945.431275403303, 4951.282064100686, 4992.8002879885125, 4824.734639594786, 4976.154053810861, 5029.270755740397, 5031.0, 5037.395512538519, 4994.625403094709, 4995.225740010304, 4999.550040496373, 5032.194848824171, 5034.798608055637, 4955.1823949048, 4964.304997300381, 4968.527989840959, 4971.801127954914, 5029.949700503022, 4047.0287131088917, 4095.7542547447247, 4150.501939767248, 4183.7324545584825, 4238.936415953764, 3660.524131862841, 3680.77915325076, 3724.981375093107, 3761.7366784324836, 3788.583255841855, 4396.3625274335045, 4398.56014398564, 4402.581754733295, 4404.559544045634, 4459.397981272552, 4907.460179380265, 5082.923756143661, 5091.0, 5099.898002039939, 5168.664036837668, 4440.888977775581, 4454.977725111418, 4462.866114016585, 4512.751798651106, 4517.570830771071, 4582.908341833145, 4583.472900616472, 4586.174488592019, 4619.607333376701, 4631.467381251132, 4594.494605593449, 4736.928946065743, 4823.807047718193, 4827.686200396963, 4839.177339852304, 5068.391792984866, 5092.6435149539175, 5112.3865136183895, 5161.483851614808, 5168.664036837594, 4807.399075115611, 4820.975895120502, 4821.349117869043, 4825.155597770447, 4885.340479035285, 4831.9275210872565, 4941.65408421407, 4979.925301120558, 5039.5968322534845, 5096.490350964874, 5037.7733002014265, 5081.695098294114, 5081.822136225214, 5118.104331742004, 5123.590112791042, 4930.408350997904, 4943.530364615356, 4945.134601444661, 4950.480199578992, 5005.199168133081, 4797.088553174885, 4921.753912304442, 4934.037862616899, 4944.851654450372, 5000.224965130411, 4886.755662216804, 4907.730074845775, 4925.729084900365, 4960.206366981266, 4972.254161875748, 5002.674826136289, 5017.974910125426, 5020.196768517019, 5024.145895197752, 5086.440491545853, 4651.0, 4684.156851766715, 4849.660523763303, 4857.514248575256, 4917.778699958439], "value": 4631.833290426456, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.640183483488, 569.9088145896658, 578.6932925549457, 582.289606679851, 584.1908956095806, 27382.452350952968, 37991.53055051423, 39513.40729889054, 39701.60298397015, 42748.358774618326, 39982.0, 40193.0, 40392.0, 40411.0, 40484.797576012155, 7152.499325047249, 7511.474196806212, 7682.807929801744, 7687.577183254919, 7698.384129269673, 7119.857602847966, 7352.04423424954, 7355.2644735526555, 9609.375390599624, 9886.456244906527, 9981.700548983506, 10032.799344013152, 10034.147097496721, 10043.296969212159, 10049.145822605087, 9857.359271647356, 9879.654212102541, 9917.90082099177, 9930.354526955725, 9930.45382503962, 9698.75753106178, 9771.902280977241, 9773.12041916231, 9774.071463210983, 9776.217902567778, 37579.62420375816, 37775.244495110215, 37876.0, 37889.621103788886, 37890.621093788985, 2644.867756612162, 2893.8263704177607, 2968.109567129874, 2969.6436427628823, 3109.689031096872, 27525.862370688217, 28414.0, 28771.56842647362, 29003.12990610285, 29583.40833183346, 3210.357928414303, 3272.132884785534, 3303.240254741423, 3328.5340052392685, 3363.4450315698127, 257528.0, 257536.0, 258613.0, 258622.0, 258813.70593147102, 30711.539326909668, 31941.201469962973, 48772.51227487751, 49065.75467122713, 49170.26244606334, 32907.0, 33109.66890331066, 33176.3364732704, 33182.336353273284, 33212.0, 13190.670233244246, 13351.399187036606, 13354.198748075147, 13354.93322533381, 13361.0, 10781.407022613832, 10838.67483975482, 10863.728406789736, 10871.130309575216, 10889.83665245022, 7165.534240274365, 7342.706291748377, 7350.926490735131, 7448.255174482617, 7542.963399882001, 2992.0, 3039.6048513693077, 3062.1579065757096, 3063.892763753258, 3086.0896035669084, 798.4769975665948, 807.7940125268136, 922.3912217936264, 943.7353945712778, 982.6658935961807, 26581.0, 27684.446311073665, 27924.58113128305, 27952.30119247035, 28060.579091313648, 885.1104639836923, 932.0586207929904, 949.5726922884592, 953.537534295866, 961.2790407194605, 14145.363458644386, 14155.787663185061, 14643.56069317922, 14869.851301487062, 14915.627109322137, 400315.0, 403015.0, 404208.0, 404589.0, 404642.0, 46766.0, 47187.29219061717, 47238.0, 47262.0, 47273.054538909026, 1075.8063548561177, 1110.189561620022, 1130.5082289204222, 1131.9434028298551, 1135.4039129456935, 25257.873710631327, 26225.475490490466, 26739.33151671224, 27211.183664490098, 27306.590401144396, 41005.58994410137, 41297.1740565181, 41359.793201033805, 41367.793161034, 41414.792926035174, 265116.0, 266185.0, 266425.0, 266603.0, 267354.0, 21221.78778212198, 21432.678509822053, 21605.0, 24414.145504907243, 24987.500249994533, 39148.41277380899, 39277.41083883687, 39485.210295793346, 39638.801805990784, 40108.79945600253, 33831.4925276126, 33938.49092263568, 34461.310773784884, 34479.827600861834, 34857.0, 33671.32657346888, 34129.48805767965, 34167.82916085404, 34409.483857742656, 35144.824275878455, 33826.83086584551, 34186.316273674885, 34446.31107377889, 34793.826030869684, 34963.77626783152, 29235.85382073076, 31171.0, 31312.373752525276, 31517.0, 31627.841860790548, 24268.393290167885, 24334.26997190087, 24374.634380484662, 24800.50398991974, 24885.377865553506], "value": 16225.549627343464, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.34778377245317, 364.38964734070436, 368.2910397484841, 378.68758274423607, 382.26414152755956, 15583.532494025183, 16263.186840657963, 17176.484705458824, 17332.566685832862, 17336.219870105844, 16453.753193702105, 16623.251953662086, 16828.915855420735, 16923.153842307896, 16951.57621059471, 4940.851774446773, 5210.42685304618, 5216.504432078947, 5216.530512253897, 5219.347581552306, 3646.2342907989355, 3848.9807550962205, 3853.7880416577077, 3910.296146693594, 5101.515356041189, 6100.816975490742, 6219.973704338801, 6230.96884515579, 6231.345708700589, 6233.7818176363835, 5999.400059994009, 6188.8762224755255, 6206.968965155168, 6215.223097112861, 6219.906701399483, 5465.125579907235, 5471.945280547184, 5475.397706252309, 5476.205950137208, 5476.288082549283, 20355.69466458004, 20435.897820510952, 20995.370138895858, 21010.789892101035, 21067.578648426945, 1691.585561537419, 1921.5484361175113, 1935.0614951748391, 2025.3215172917091, 2445.8410203336725, 8958.507282099481, 9172.036936121678, 11143.498542565603, 12442.19125756832, 12458.937705311506, 1704.514213449161, 1743.5292471032876, 1748.4230204032638, 1757.0599729144974, 1760.3310741918117, 70243.29756702419, 70324.64837675779, 71031.0, 71182.64408677975, 71954.0, 9089.95455022734, 9268.25853931684, 9277.489738064336, 10097.545610447547, 10303.639372621923, 14175.574732758034, 14176.85823141776, 14188.219647919257, 14204.28978551089, 14215.85784142166, 7346.669399877019, 7496.475246732676, 7565.394768418513, 7743.4966727162555, 7762.534247945141, 7171.677274522659, 7179.461540384492, 7431.85136297271, 7441.962790186014, 7453.291937265951, 4264.296391095435, 4376.256036473807, 4400.889977750582, 4475.910481790411, 4516.593506584358, 1618.8623966962705, 1715.2110029386372, 1754.7280171573427, 1786.6605344984412, 1833.5874428253803, 675.7432175773175, 800.5076877720277, 854.9016863060828, 855.5978690015683, 876.8860048193694, 16740.330386784637, 16756.16219189036, 17554.0, 17610.29558817633, 17874.0, 800.8198155414985, 814.3729328417204, 865.1996902864825, 871.8387098386819, 922.5433410461865, 9529.90470095304, 9936.50317484123, 9990.900090999143, 10001.899981000097, 10042.447665378328, 385243.0, 390128.0, 392641.0, 393516.0, 395037.0, 49989.0, 60470.09294860493, 78765.60617196992, 81756.0, 82709.0, 865.8874346334936, 878.1043335797451, 883.9513826739591, 891.7681402835179, 894.6868595991351, 15086.849131508545, 15210.859185560907, 15792.289346979183, 15817.68364632724, 16156.757648635516, 37361.4395784058, 37861.43207851939, 38656.2268754629, 39000.41499377568, 39357.409638854864, 50365.49634503754, 52882.735586321825, 53382.0, 54185.0, 54753.0, 7281.162666293444, 7313.378362839218, 7566.697332106654, 7691.57696326685, 7881.172476889844, 6911.723531058701, 7753.108392534705, 11479.713007174887, 11823.290602563873, 12674.493020279455, 9464.432134071978, 9663.855042174513, 9794.461304628314, 10284.228682848667, 10859.83710244331, 9868.210543156387, 10443.68668939933, 10469.371837689763, 10516.842247366449, 10620.309679870783, 9597.664081757104, 9792.629031935392, 10335.328203666737, 10754.83867742, 11105.555777768799, 7500.62496875165, 7621.733239336597, 7639.121501027453, 7643.656035478528, 7911.683532658629, 9719.9028009719, 10405.84391234117, 10714.785704286027, 10810.621628242974, 11068.944655276671], "value": 8234.542764172875, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.3883444198445, 1358.8641135886412, 1371.8833899118574, 1606.8071831380237, 1644.8437398447143, 6758.594484330932, 7422.777316680495, 7518.248175182493, 7972.162922893092, 8009.719659811908, 7489.887651685229, 7756.379489640829, 7791.18192589777, 7803.18066603007, 7812.843743125134, 2153.956920861578, 2167.6531754919215, 2175.053851574562, 2176.227439259064, 2187.704659870913, 1833.9174737136793, 2096.224396973122, 2130.5845360154776, 2164.437246315961, 2175.3800166952424, 2156.428546435196, 2169.739631244253, 2183.2031308572414, 2191.2659259148204, 2197.7582465928813, 2105.0, 2113.2075471698113, 2172.663237198237, 2175.510510135223, 2176.0425412818468, 2097.674860396641, 2115.386537904021, 2117.95764084719, 2130.561870737246, 2130.7762684918016, 7980.0, 8027.076886158108, 8041.316488098519, 8054.838903221903, 8056.516609003478, 4407.559244075599, 4466.106778644252, 4525.637948964075, 4527.637788976874, 4545.0, 2920.0509834303934, 2967.6735559088484, 3054.129573071664, 3060.816351018924, 3075.4310452566347, 924.1359329027381, 958.2669258017622, 958.6692591056144, 958.942463452195, 976.511744127936, 10656.20078494116, 10720.624778132727, 10724.892751072468, 10746.838797418044, 10749.892501074968, 4142.109446469024, 4261.637760790306, 4355.62977146946, 4362.367456718758, 4367.170237654899, 9189.586468608928, 9194.402363846328, 9201.539923003824, 9204.171624553823, 9204.309676774135, 4474.888127796766, 4510.932336014962, 4511.954880451219, 4522.462362796665, 4525.818967241339, 3997.420374045805, 4110.671146308348, 4115.032967252693, 4123.154753275571, 4123.9175216495505, 3560.092176494977, 3627.510286111341, 3665.2303016366327, 3684.8811933138554, 3693.575238847567, 1098.1215027977746, 1168.4333098447246, 1182.5269892043252, 1195.4441184849086, 1229.538922903911, 711.3100292716057, 840.2521755637488, 849.197508354599, 850.6469815026818, 858.4720396955827, 5295.205719142159, 5372.597055220874, 5508.669479831223, 5582.0, 5593.888122237532, 791.133708589094, 819.8975128108987, 831.1522247307712, 856.8971723393232, 873.1225118755737, 3758.1919887224376, 3822.636849499293, 3844.2888065707934, 3863.517060367454, 3975.026118600961, 9167.908320916838, 9466.05339466048, 9654.420734755937, 9721.513924303756, 9763.707088787347, 9652.372595781251, 9658.517074146404, 9662.71011869645, 9669.081437263449, 9676.90323096774, 6863.347981941807, 7091.716331346792, 7119.75080872167, 7147.2852714728115, 7156.713731450684, 5363.758630861698, 5388.164834450667, 5416.0, 5582.525485333792, 5692.971535142297, 8792.824143517222, 8842.115788421364, 8972.19250267479, 9040.728778136667, 9065.909340906506, 9035.954820225857, 9063.320250981335, 9141.497217653094, 9165.816683666422, 9228.538573071453, 6792.456603471809, 6904.067950826574, 6908.585484870924, 6908.723651054102, 6912.861742765016, 7298.2701729826595, 7381.704731810667, 7445.9627701861145, 7446.7021319146625, 7461.141968673672, 6620.404163625297, 6738.124043874265, 6816.352446517573, 6845.315468453115, 7017.754378596725, 6644.800655980328, 6645.102911107132, 6657.300983396867, 6672.599644021374, 6699.9665001674675, 6323.36766323364, 6413.7113829876835, 6466.385693359123, 6467.3209313023335, 6481.287058423475, 4582.587567118975, 4647.16351056813, 4664.230401983635, 4670.6263498919325, 4761.6429867214565, 4563.543645635543, 4609.078184363074, 4646.140464014168, 4662.883427914329, 4714.22215334466], "value": 4152.463368933936, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.71994884910487, 296.83673979311374, 298.6401386329473, 305.6286611766703, 309.1205520294761, 4760.690555113915, 4765.618750499961, 4767.666263361566, 4796.184648609736, 4817.8072877084915, 4716.811327546894, 4716.952830471694, 4720.268358404444, 4722.417989973363, 4727.8818029549275, 3782.0922978485105, 3791.6397942195586, 3791.7345785795005, 3799.8670046548445, 3799.905002374935, 3485.6862882340583, 3822.7706337619693, 3823.5985221551755, 3830.731848770587, 3837.0982819037645, 3666.5600127984544, 3709.9039042940653, 3712.0, 3724.3854763963914, 3729.1236559408653, 3678.779273243614, 3688.6311368863167, 3690.612485688991, 3692.981535092334, 3714.53568303962, 3050.283183451887, 3122.5324097674056, 3240.3636163737397, 3241.5785947826867, 3243.562119113913, 4621.445426548836, 4626.9074618507775, 4636.211843986531, 4649.976750116228, 4655.88360290992, 4180.47744031996, 4181.289180839264, 4185.560516145822, 4200.264953633133, 4204.831806727727, 4625.866662667668, 4682.41469816273, 4893.559579637849, 4903.460619331906, 4960.90078198434, 3387.5596172497662, 3397.7621566490357, 3405.540252065989, 3422.9315413691834, 3424.8116353600544, 5119.539241468286, 5157.008934817797, 5158.9484105158845, 5174.146265866128, 5194.467632048555, 3428.405791307004, 3602.1534939289245, 3622.166901612644, 3626.0, 3630.636936306348, 3634.4184930411006, 3656.3784156693428, 3662.1210909381557, 3665.8086122010454, 3667.688246499024, 4166.812493437803, 4185.058361868555, 4185.618745813874, 4186.91626167475, 4196.244675958295, 4940.777665005084, 4951.430585482715, 4959.801607935642, 4961.4046314441775, 4967.875803104951, 1234.216272666863, 1252.8621851596317, 1262.810578413227, 1266.2402558464848, 1271.9618411447486, 794.7337641889916, 809.6073404398862, 817.2195553246635, 822.1490757066407, 829.1335554345724, 3975.860844870416, 4015.297322968469, 4015.678745700337, 4023.3763766615634, 4027.81874815634, 4526.70375660478, 4542.704724192917, 4544.863654090383, 4588.403507543998, 4607.44710634726, 4036.192761447722, 4037.232925744158, 4038.788363491, 4046.656034237064, 4050.3924411338535, 2348.09804058713, 2428.7206971198184, 2428.7571242875924, 2445.400876785199, 2449.4856080223, 4347.934780978288, 4626.154914727485, 4668.883277918079, 4822.156122678517, 4843.418789745183, 5206.193040078794, 5217.713025783542, 5224.660397074178, 5250.842474725764, 5255.947440525622, 4846.224604063333, 4851.078295123915, 4854.208829922809, 4873.878153046131, 4874.683145595525, 4991.301217829579, 5128.846009647948, 5148.58811295103, 5152.3044389007, 5163.8192663256605, 4986.805805445592, 5058.747062646927, 5061.974690126526, 5067.923981140212, 5073.974630126826, 4699.5770380664535, 4833.371661683958, 4834.540718631724, 4847.684900481458, 4849.224124140121, 3606.3688854450893, 3608.80151591665, 3615.6203598621764, 3628.0, 3631.1648320885815, 5099.898002040012, 5101.744912754273, 5106.80824484697, 5113.53978141969, 5123.487651234996, 4953.854302517855, 4954.529319714621, 4970.378702662168, 4988.326575912351, 5014.395393474053, 4738.265568836836, 4946.925796113133, 4963.503649635008, 4969.975150124226, 4970.304157418037, 4893.632977526629, 4895.779689913891, 4896.559309662148, 4904.803807847647, 4975.6019518437715, 5048.974755126201, 5051.166557518115, 5060.304797892747, 5061.31672224245, 5072.858606813437, 4602.516735742699, 4824.807007719793, 4888.095702295087, 4888.828890988798, 4906.852794416173], "value": 3696.8944986350643, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.73910218606, 701.2776839854952, 718.1740997852472, 739.1610522057463, 743.3867059675769, 12491.375431228436, 12947.741045179091, 13029.73940521189, 13057.73884522309, 13159.605211843647, 12999.0, 13156.473741050371, 13157.276349800757, 13163.934180329108, 13179.604611861636, 588.364566268429, 716.0691101567967, 717.429643433469, 738.401894465482, 743.1453828097677, 744.0401881572792, 744.94040476762, 747.1482509938675, 747.5701471653794, 748.2293237964905, 782.636074225485, 783.6238605469379, 783.8471498057881, 784.3411534311177, 784.3881772217679, 617.7745123030085, 747.2527472527472, 767.2136060537938, 768.4198430185174, 774.573984308628, 563.7660370946094, 566.7449647658528, 566.9433056694297, 567.013396689761, 567.3645517020922, 12522.436490357955, 12550.435230414654, 12563.623091307276, 12572.874271257262, 12575.874241257561, 12577.182483138567, 13004.60986170407, 13283.335833208397, 13361.198328100345, 13679.726405471934, 11859.584914528037, 12071.336076515789, 12102.213356131822, 12283.447244874002, 12515.874841251562, 4031.173609410064, 4032.858849940238, 4043.9595604043875, 4099.077707515815, 4154.148399578079, 61340.0, 61348.07977880335, 63635.0, 65569.67215163942, 65790.67104664494, 10180.134688551409, 10273.691789246335, 10307.484625768682, 10449.634262800766, 10846.349219046724, 19217.80782192188, 19223.807761922482, 19233.80766192348, 19294.22823087089, 19356.0, 6872.896906546306, 6896.482763792736, 7004.205113896748, 7160.355567998801, 7194.172670143001, 3652.7808331500196, 3664.450332450154, 3669.192777588926, 3678.117251859588, 3783.2244389900006, 2771.5426954552677, 2875.0368626509935, 3156.9684303156673, 3362.815045172539, 3364.62989071202, 557.1336571631152, 566.1620801214226, 569.1462805791313, 570.2814453788174, 572.0475408444976, 520.8723862653674, 588.1060787602905, 616.7286393986632, 618.1839971237923, 624.2945471617135, 7743.5353878767455, 7775.92224077752, 7977.641006154737, 8074.0, 8201.917980820235, 477.7563442644207, 514.2337916504382, 522.5062316111314, 544.238066706606, 565.8019693107461, 3772.641599048086, 3817.408301713239, 3952.7035472339116, 3990.700697447645, 4012.959870401317, 77799.22200778034, 79428.60285698535, 99875.0, 109024.4548777251, 109158.0, 89508.5524572373, 92175.0, 92524.53737731268, 92815.53592231996, 93380.0, 47376.64924072691, 81120.59439702882, 81408.59295703602, 81681.18318816855, 81814.59092704498, 7478.775636730907, 7625.3137217648455, 7641.541507509567, 7676.232376762502, 7713.845723085619, 45483.31775023443, 45785.313220301054, 46903.76548117238, 48112.518874810805, 49158.0, 60033.0, 66734.0, 67446.26706729984, 67746.66126669335, 70471.0, 8875.378723489293, 9087.273418050549, 9117.817643647222, 9300.255979521757, 9609.0, 9795.51022448889, 9837.0, 10121.949390253001, 11020.944895275794, 11910.880891191324, 10547.683569492927, 10581.62964296246, 10698.358098514114, 10882.0, 10989.835152472879, 9707.369021013612, 9888.703338899844, 10002.849957250794, 10027.097561219525, 10340.482975851328, 9644.807103858024, 9715.319927605, 10007.449590272605, 10131.189504839447, 10442.843357349493, 8907.866382004404, 9176.541172941459, 9341.590319533458, 9476.763080923032, 9638.807223855623, 8103.513789172668, 8120.14738452454, 8412.831743365221, 8422.789430264293, 8458.28104611115], "value": 6422.066434050238, "unit": "score"}], "name": "dromaeo_css", "value": 6274.457597742606, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 115.0, 120.0, 117.0, 113.0, 114.0, 114.0, 116.0, 116.0, 130.0], "value": 117.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 128.0, 153.0, 191.0, 125.0, 144.0, 154.0, 123.0, 183.0, 123.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 162.0, 161.0, 161.0, 163.0, 166.0, 164.0, 164.0, 163.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 167.0, 80.0, 76.0, 77.0, 77.0, 160.0, 76.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 158.0, 84.0, 84.0, 84.0, 149.0, 83.0, 83.0, 137.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 65.0, 67.0, 69.0, 68.0, 78.0, 65.0, 65.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 68.0, 66.0, 66.0, 67.0, 67.0, 67.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 84.0, 83.0, 83.0, 91.0, 83.0, 84.0, 83.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 136.0, 143.0, 132.0, 136.0, 141.0, 145.0, 158.0, 177.0, 135.0], "value": 144.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 180.0, 179.0, 181.0, 179.0, 179.0, 183.0, 181.0, 179.0, 189.0], "value": 180.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 72.0, 69.0, 69.0, 70.0, 69.0, 74.0, 70.0, 72.0], "value": 70.6, "unit": "score"}], "name": "kraken", "value": 1598.2999999999997, "alertThreshold": 2.0}]} 14:35:11 INFO - Return code: 0 14:35:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:35:11 INFO - # TBPL SUCCESS # 14:35:11 INFO - Running post-action listener: _resource_record_post_action 14:35:11 INFO - [mozharness: 2016-09-02 21:35:11.383452Z] Finished run-tests step (success) 14:35:11 INFO - Running post-run listener: _resource_record_post_run 14:35:11 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 16384; Write bytes: 416268288; Read time: 352; Write time: 349040 14:35:11 INFO - TinderboxPrint: CPU usage
13.1% 14:35:11 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 352 14:35:11 INFO - TinderboxPrint: I/O write bytes / time
416,268,288 / 349,040 14:35:11 INFO - TinderboxPrint: CPU idle
8,343.1 (86.9%) 14:35:11 INFO - TinderboxPrint: CPU user
1,205.4 (12.6%) 14:35:11 INFO - TinderboxPrint: Swap in / out
0 / 0 14:35:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 124993536; Read time: 124; Write time: 114780 14:35:11 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 290357248; Read time: 212; Write time: 234236 14:35:12 INFO - Running post-run listener: _upload_blobber_files 14:35:12 INFO - Blob upload gear active. 14:35:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:35:12 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 14:35:12 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'] 14:35:12 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 14:35:12 INFO - (blobuploader) - INFO - Open directory for files ... 14:35:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:35:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:35:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:35:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:35:16 INFO - (blobuploader) - INFO - Done attempting. 14:35:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:35:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:35:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:35:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:35:18 INFO - (blobuploader) - INFO - Done attempting. 14:35:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:35:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:35:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:35:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:35:19 INFO - (blobuploader) - INFO - Done attempting. 14:35:19 INFO - (blobuploader) - INFO - Iteration through files over. 14:35:19 INFO - Return code: 0 14:35:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:35:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:35:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f6c04c5e67378ae51f2b939c7174127c4298897f95e6b1f97416b17a6820fc2f13116cc2d59b69418e379f71846f69e792b55a6c10ded0b690b939936f17084", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e125bc9afd92f80a71d3648c130e8e85269d6b73b6036cac85bf8f9d5b7d5f5495119a1129e4e86a4e43e294cc4e68befa3674e9d1ab847a4755d6d69d9e87f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35ee2aab994492f23f6b01dd2623f6b5e9ca2f4ae02f32e37bcf45c1ff40d46a4ada0e51f1a8564d87b1c8722eb5c84f66bf90f32a23522fb246a89f35c853c4"} 14:35:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:35:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:35:19 INFO - Contents: 14:35:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f6c04c5e67378ae51f2b939c7174127c4298897f95e6b1f97416b17a6820fc2f13116cc2d59b69418e379f71846f69e792b55a6c10ded0b690b939936f17084", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e125bc9afd92f80a71d3648c130e8e85269d6b73b6036cac85bf8f9d5b7d5f5495119a1129e4e86a4e43e294cc4e68befa3674e9d1ab847a4755d6d69d9e87f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35ee2aab994492f23f6b01dd2623f6b5e9ca2f4ae02f32e37bcf45c1ff40d46a4ada0e51f1a8564d87b1c8722eb5c84f66bf90f32a23522fb246a89f35c853c4"} 14:35:19 INFO - Running post-run listener: copy_logs_to_upload_dir 14:35:19 INFO - Copying logs to upload dir... 14:35:19 INFO - mkdir: /builds/slave/test/build/upload/logs 14:35:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.703643 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-02 14:35:18.117220) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 14:35:18.121069) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727 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/5f6c04c5e67378ae51f2b939c7174127c4298897f95e6b1f97416b17a6820fc2f13116cc2d59b69418e379f71846f69e792b55a6c10ded0b690b939936f17084", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e125bc9afd92f80a71d3648c130e8e85269d6b73b6036cac85bf8f9d5b7d5f5495119a1129e4e86a4e43e294cc4e68befa3674e9d1ab847a4755d6d69d9e87f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35ee2aab994492f23f6b01dd2623f6b5e9ca2f4ae02f32e37bcf45c1ff40d46a4ada0e51f1a8564d87b1c8722eb5c84f66bf90f32a23522fb246a89f35c853c4"} build_url:https://queue.taskcluster.net/v1/task/eU2wsUGRQjKxb_STbQntAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011358 build_url: 'https://queue.taskcluster.net/v1/task/eU2wsUGRQjKxb_STbQntAg/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/5f6c04c5e67378ae51f2b939c7174127c4298897f95e6b1f97416b17a6820fc2f13116cc2d59b69418e379f71846f69e792b55a6c10ded0b690b939936f17084", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e125bc9afd92f80a71d3648c130e8e85269d6b73b6036cac85bf8f9d5b7d5f5495119a1129e4e86a4e43e294cc4e68befa3674e9d1ab847a4755d6d69d9e87f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35ee2aab994492f23f6b01dd2623f6b5e9ca2f4ae02f32e37bcf45c1ff40d46a4ada0e51f1a8564d87b1c8722eb5c84f66bf90f32a23522fb246a89f35c853c4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 14:35:18.146122) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:35:18.146444) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1472850867.780595-101630727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:35:18.230472) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 14:35:18.230787) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 14:35:18.231079) ========= ========= Total master_lag: 0.15 =========