builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-052 starttime: 1472906931.16 results: success (0) buildid: 20160903030202 builduid: 477c217fa5694c43b708706287c3f8d5 revision: d0830980ffdb36a10855d02a588b4869cad6707e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-03 05:48:51.162200) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-03 05:48:51.162659) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-03 05:48:51.162996) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-03 05:48:51.201563) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 05:48:51.201886) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-03 05:48:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.3M=0s 2016-09-03 05:48:51 (67.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.343038 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 05:48:51.559599) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 05:48:51.559971) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017481 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 05:48:51.610513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 05:48:51.610932) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d0830980ffdb36a10855d02a588b4869cad6707e --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 d0830980ffdb36a10855d02a588b4869cad6707e --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-03 05:48:51,712 truncating revision to first 12 chars 2016-09-03 05:48:51,712 Setting DEBUG logging. 2016-09-03 05:48:51,712 attempt 1/10 2016-09-03 05:48:51,712 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d0830980ffdb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-03 05:48:52,002 unpacking tar archive at: mozilla-central-d0830980ffdb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.602845 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 05:48:52.231644) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-03 05:48:52.232452) ========= script_repo_revision: d0830980ffdb36a10855d02a588b4869cad6707e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-03 05:48:52.233532) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-03 05:48:52.234341) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-03 05:48:52.246299) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-09-03 05:48:52.246639) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:48:52 INFO - MultiFileLogger online at 20160903 05:48:52 in /builds/slave/test 05:48:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:48:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:48:52 INFO - {'append_to_log': False, 05:48:52 INFO - 'base_work_dir': '/builds/slave/test', 05:48:52 INFO - 'blob_upload_branch': 'Firefox', 05:48:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:48:52 INFO - 'branch': 'Firefox', 05:48:52 INFO - 'buildbot_json_path': 'buildprops.json', 05:48:52 INFO - 'config_files': ('talos/linux_config.py',), 05:48:52 INFO - 'default_actions': ('clobber', 05:48:52 INFO - 'read-buildbot-config', 05:48:52 INFO - 'download-and-extract', 05:48:52 INFO - 'populate-webroot', 05:48:52 INFO - 'create-virtualenv', 05:48:52 INFO - 'install', 05:48:52 INFO - 'run-tests'), 05:48:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:48:52 INFO - 'download_minidump_stackwalk': True, 05:48:52 INFO - 'download_symbols': 'ondemand', 05:48:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:48:52 INFO - 'tooltool.py': '/tools/tooltool.py', 05:48:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:48:52 INFO - '/tools/misc-python/virtualenv.py')}, 05:48:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:48:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:48:52 INFO - 'installer_path': 'installer.exe', 05:48:52 INFO - 'log_level': 'info', 05:48:52 INFO - 'log_name': 'talos', 05:48:52 INFO - 'log_to_console': True, 05:48:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:48:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:48:52 INFO - 'opt_config_files': (), 05:48:52 INFO - 'pip_index': False, 05:48:52 INFO - 'sps_profile': False, 05:48:52 INFO - 'sps_profile_interval': 0, 05:48:52 INFO - 'suite': 'dromaeojs', 05:48:52 INFO - 'system_bits': '32', 05:48:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:48:52 INFO - 'title': 'talos-linux64-ix-052', 05:48:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:48:52 INFO - 'use_talos_json': True, 05:48:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:48:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:48:52 INFO - 'work_dir': 'build'} 05:48:52 INFO - [mozharness: 2016-09-03 12:48:52.445880Z] Running clobber step. 05:48:52 INFO - Running pre-action listener: _resource_record_pre_action 05:48:52 INFO - Running main action method: clobber 05:48:52 INFO - rmtree: /builds/slave/test/build 05:48:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:48:53 INFO - Running post-action listener: _resource_record_post_action 05:48:53 INFO - [mozharness: 2016-09-03 12:48:53.401395Z] Finished clobber step (success) 05:48:53 INFO - [mozharness: 2016-09-03 12:48:53.401494Z] Running read-buildbot-config step. 05:48:53 INFO - Running pre-action listener: _resource_record_pre_action 05:48:53 INFO - Running main action method: read_buildbot_config 05:48:53 INFO - Using buildbot properties: 05:48:53 INFO - { 05:48:53 INFO - "project": "", 05:48:53 INFO - "product": "firefox", 05:48:53 INFO - "script_repo_revision": "production", 05:48:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:48:53 INFO - "repository": "", 05:48:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:48:53 INFO - "buildid": "20160903030202", 05:48:53 INFO - "stage_platform": "linux64-pgo", 05:48:53 INFO - "basedir": "/builds/slave/test", 05:48:53 INFO - "nightly_build": "True", 05:48:53 INFO - "buildnumber": 559, 05:48:53 INFO - "slavename": "talos-linux64-ix-052", 05:48:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:48:53 INFO - "platform": "ubuntu64_hw", 05:48:53 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:48:53 INFO - "branch": "mozilla-central", 05:48:53 INFO - "repo_path": "mozilla-central", 05:48:53 INFO - "revision": "d0830980ffdb36a10855d02a588b4869cad6707e", 05:48:53 INFO - "pgo_build": "True", 05:48:53 INFO - "builduid": "477c217fa5694c43b708706287c3f8d5", 05:48:53 INFO - "slavebuilddir": "test" 05:48:53 INFO - } 05:48:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:48:53 INFO - Running post-action listener: _resource_record_post_action 05:48:53 INFO - [mozharness: 2016-09-03 12:48:53.404013Z] Finished read-buildbot-config step (success) 05:48:53 INFO - [mozharness: 2016-09-03 12:48:53.404102Z] Running download-and-extract step. 05:48:53 INFO - Running pre-action listener: _resource_record_pre_action 05:48:53 INFO - Running main action method: download_and_extract 05:48:53 INFO - mkdir: /builds/slave/test/build/tests 05:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:53 INFO - trying https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:48:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:48:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:48:53 INFO - Downloaded 1361 bytes. 05:48:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:48:53 INFO - Using the following test package requirements: 05:48:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:48:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:48:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:48:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:53 INFO - u'jsshell-linux-x86_64.zip'], 05:48:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:48:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:48:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:48:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:48:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:48:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:48:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:53 INFO - trying https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:48:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:48:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:48:54 INFO - Downloaded 21906680 bytes. 05:48:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 05:48:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:48: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')]} 05:48:59 INFO - trying https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:48:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:48:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:48:59 INFO - Downloaded 21906680 bytes. 05:48:59 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 05:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:04 INFO - trying https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:49:05 INFO - Downloaded 14413998 bytes. 05:49:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 05:49:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:05 INFO - trying https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:49:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:49:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:49:07 INFO - Downloaded 59696376 bytes. 05:49:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:49:07 INFO - mkdir: /builds/slave/test/properties 05:49:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:49:07 INFO - Writing to file /builds/slave/test/properties/build_url 05:49:07 INFO - Contents: 05:49:07 INFO - build_url:https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:49:07 INFO - Running post-action listener: _resource_record_post_action 05:49:07 INFO - Running post-action listener: set_extra_try_arguments 05:49:07 INFO - [mozharness: 2016-09-03 12:49:07.672010Z] Finished download-and-extract step (success) 05:49:07 INFO - [mozharness: 2016-09-03 12:49:07.672237Z] Running populate-webroot step. 05:49:07 INFO - Running pre-action listener: _resource_record_pre_action 05:49:07 INFO - Running main action method: populate_webroot 05:49:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:49:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:49:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:49:07 INFO - '--tppagecycles', 05:49:07 INFO - '7'], 05:49:07 INFO - 'tests': ['tsvgm']}}, 05:49:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:49:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:49:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:49:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:49:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:49:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:49:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:07 INFO - 'talos_options': ['--disable-e10s'], 05:49:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:07 INFO - 'talos_options': ['--disable-e10s'], 05:49:07 INFO - 'tests': ['damp', 'tps']}, 05:49:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:07 INFO - 'tests': ['damp', 'tps']}, 05:49:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:49:07 INFO - 'tests': ['dromaeo_dom']}, 05:49:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:49:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:49:07 INFO - 'tests': ['basic_compositor_video']}, 05:49:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:49:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:49:07 INFO - 'tests': ['a11yr', 05:49:07 INFO - 'ts_paint', 05:49:07 INFO - 'tpaint', 05:49:07 INFO - 'sessionrestore', 05:49:07 INFO - 'sessionrestore_no_auto_restore', 05:49:07 INFO - 'tabpaint']}, 05:49:07 INFO - 'other-e10s': {'tests': ['a11yr', 05:49:07 INFO - 'ts_paint', 05:49:07 INFO - 'tpaint', 05:49:07 INFO - 'sessionrestore', 05:49:07 INFO - 'sessionrestore_no_auto_restore', 05:49:07 INFO - 'tabpaint']}, 05:49:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:49:07 INFO - 'ts_paint', 05:49:07 INFO - 'tpaint', 05:49:07 INFO - 'sessionrestore', 05:49:07 INFO - 'sessionrestore_no_auto_restore', 05:49:07 INFO - 'tabpaint']}, 05:49:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:49:07 INFO - 'ts_paint', 05:49:07 INFO - 'tpaint', 05:49:07 INFO - 'sessionrestore', 05:49:07 INFO - 'sessionrestore_no_auto_restore', 05:49:07 INFO - 'tabpaint']}, 05:49:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:49:07 INFO - 'tests': ['a11yr', 05:49:07 INFO - 'ts_paint', 05:49:07 INFO - 'tpaint', 05:49:07 INFO - 'sessionrestore', 05:49:07 INFO - 'sessionrestore_no_auto_restore', 05:49:07 INFO - 'tabpaint']}, 05:49:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:49:07 INFO - 'tests': ['a11yr', 05:49:07 INFO - 'ts_paint', 05:49:07 INFO - 'tpaint', 05:49:07 INFO - 'sessionrestore', 05:49:07 INFO - 'sessionrestore_no_auto_restore', 05:49:07 INFO - 'tabpaint']}, 05:49:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:49:07 INFO - 'tests': ['tsvgx', 05:49:07 INFO - 'tsvgr_opacity', 05:49:07 INFO - 'tart', 05:49:07 INFO - 'tscrollx', 05:49:07 INFO - 'cart']}, 05:49:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:49:07 INFO - 'tsvgr_opacity', 05:49:07 INFO - 'tart', 05:49:07 INFO - 'tscrollx', 05:49:07 INFO - 'cart']}, 05:49:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:07 INFO - 'talos_options': ['--disable-e10s'], 05:49:07 INFO - 'tests': ['tp5o']}, 05:49:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:07 INFO - 'tests': ['tp5o']}, 05:49:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:07 INFO - 'talos_options': ['--disable-e10s', 05:49:07 INFO - '--xperf_path', 05:49:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:07 INFO - 'tests': ['tp5n']}, 05:49:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:07 INFO - 'talos_options': ['--xperf_path', 05:49:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:07 INFO - 'tests': ['tp5n']}}, 05:49:07 INFO - 'talos.zip': {'path': '', 05:49:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:49:07 INFO - Running post-action listener: _resource_record_post_action 05:49:07 INFO - [mozharness: 2016-09-03 12:49:07.692253Z] Finished populate-webroot step (success) 05:49:07 INFO - [mozharness: 2016-09-03 12:49:07.692343Z] Running create-virtualenv step. 05:49:07 INFO - Running pre-action listener: _resource_record_pre_action 05:49:07 INFO - Running main action method: create_virtualenv 05:49:07 INFO - Creating virtualenv /builds/slave/test/build/venv 05:49:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:49:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:49:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:49:07 INFO - Using real prefix '/usr' 05:49:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:49:08 INFO - Installing distribute.............................................................................................................................................................................................done. 05:49:10 INFO - Installing pip.................done. 05:49:10 INFO - Return code: 0 05:49:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdf1890f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a758d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b04760>, '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 0x2b05660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b05af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:49:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:49:10 INFO - Using env: {'DISPLAY': ':0', 05:49:10 INFO - 'HOME': '/home/cltbld', 05:49:10 INFO - 'LANG': 'en_US.UTF-8', 05:49:10 INFO - 'LANGUAGE': 'en_US:en', 05:49:10 INFO - 'LOGNAME': 'cltbld', 05:49:10 INFO - 'MAIL': '/var/mail/cltbld', 05:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:10 INFO - 'MOZ_NO_REMOTE': '1', 05:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:10 INFO - 'NO_EM_RESTART': '1', 05:49:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:10 INFO - 'PWD': '/builds/slave/test', 05:49:10 INFO - 'SHELL': '/bin/bash', 05:49:10 INFO - 'SHLVL': '1', 05:49:10 INFO - 'TERM': 'linux', 05:49:10 INFO - 'TMOUT': '86400', 05:49:10 INFO - 'USER': 'cltbld', 05:49:10 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452', 05:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:10 INFO - '_': '/tools/buildbot/bin/python'} 05:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:49:10 INFO - Cleaning up... 05:49:10 INFO - Return code: 0 05:49:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdf1890f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a758d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b04760>, '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 0x2b05660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b05af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:49:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:49:10 INFO - Using env: {'DISPLAY': ':0', 05:49:10 INFO - 'HOME': '/home/cltbld', 05:49:10 INFO - 'LANG': 'en_US.UTF-8', 05:49:10 INFO - 'LANGUAGE': 'en_US:en', 05:49:10 INFO - 'LOGNAME': 'cltbld', 05:49:10 INFO - 'MAIL': '/var/mail/cltbld', 05:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:10 INFO - 'MOZ_NO_REMOTE': '1', 05:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:10 INFO - 'NO_EM_RESTART': '1', 05:49:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:10 INFO - 'PWD': '/builds/slave/test', 05:49:10 INFO - 'SHELL': '/bin/bash', 05:49:10 INFO - 'SHLVL': '1', 05:49:10 INFO - 'TERM': 'linux', 05:49:10 INFO - 'TMOUT': '86400', 05:49:10 INFO - 'USER': 'cltbld', 05:49:10 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452', 05:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:10 INFO - '_': '/tools/buildbot/bin/python'} 05:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:10 INFO - Downloading/unpacking psutil>=3.1.1 05:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:49:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:12 INFO - Installing collected packages: psutil 05:49:12 INFO - Running setup.py install for psutil 05:49:12 INFO - building 'psutil._psutil_linux' extension 05:49:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:49:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:49:12 INFO - building 'psutil._psutil_posix' extension 05:49:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:49:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:49:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:13 INFO - Successfully installed psutil 05:49:13 INFO - Cleaning up... 05:49:13 INFO - Return code: 0 05:49:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdf1890f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a758d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b04760>, '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 0x2b05660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b05af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:49:13 INFO - Using env: {'DISPLAY': ':0', 05:49:13 INFO - 'HOME': '/home/cltbld', 05:49:13 INFO - 'LANG': 'en_US.UTF-8', 05:49:13 INFO - 'LANGUAGE': 'en_US:en', 05:49:13 INFO - 'LOGNAME': 'cltbld', 05:49:13 INFO - 'MAIL': '/var/mail/cltbld', 05:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:13 INFO - 'MOZ_NO_REMOTE': '1', 05:49:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:13 INFO - 'NO_EM_RESTART': '1', 05:49:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:13 INFO - 'PWD': '/builds/slave/test', 05:49:13 INFO - 'SHELL': '/bin/bash', 05:49:13 INFO - 'SHLVL': '1', 05:49:13 INFO - 'TERM': 'linux', 05:49:13 INFO - 'TMOUT': '86400', 05:49:13 INFO - 'USER': 'cltbld', 05:49:13 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452', 05:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:13 INFO - '_': '/tools/buildbot/bin/python'} 05:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:49:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:49:15 INFO - Installing collected packages: mozsystemmonitor 05:49:15 INFO - Running setup.py install for mozsystemmonitor 05:49:15 INFO - Successfully installed mozsystemmonitor 05:49:15 INFO - Cleaning up... 05:49:15 INFO - Return code: 0 05:49:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdf1890f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a758d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b04760>, '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 0x2b05660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b05af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:49:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:49:15 INFO - Using env: {'DISPLAY': ':0', 05:49:15 INFO - 'HOME': '/home/cltbld', 05:49:15 INFO - 'LANG': 'en_US.UTF-8', 05:49:15 INFO - 'LANGUAGE': 'en_US:en', 05:49:15 INFO - 'LOGNAME': 'cltbld', 05:49:15 INFO - 'MAIL': '/var/mail/cltbld', 05:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:15 INFO - 'MOZ_NO_REMOTE': '1', 05:49:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:15 INFO - 'NO_EM_RESTART': '1', 05:49:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:15 INFO - 'PWD': '/builds/slave/test', 05:49:15 INFO - 'SHELL': '/bin/bash', 05:49:15 INFO - 'SHLVL': '1', 05:49:15 INFO - 'TERM': 'linux', 05:49:15 INFO - 'TMOUT': '86400', 05:49:15 INFO - 'USER': 'cltbld', 05:49:15 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452', 05:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:15 INFO - '_': '/tools/buildbot/bin/python'} 05:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:15 INFO - Downloading/unpacking jsonschema==2.5.1 05:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:49:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:17 INFO - Downloading functools32-3.2.3-2.tar.gz 05:49:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:49:17 INFO - warning: no files found matching '*.txt' 05:49:17 INFO - no previously-included directories found matching 'build' 05:49:17 INFO - no previously-included directories found matching 'dist' 05:49:17 INFO - no previously-included directories found matching '.git*' 05:49:17 INFO - Installing collected packages: jsonschema, functools32 05:49:17 INFO - Running setup.py install for functools32 05:49:18 INFO - warning: no files found matching '*.txt' 05:49:18 INFO - no previously-included directories found matching 'build' 05:49:18 INFO - no previously-included directories found matching 'dist' 05:49:18 INFO - no previously-included directories found matching '.git*' 05:49:18 INFO - Successfully installed jsonschema functools32 05:49:18 INFO - Cleaning up... 05:49:18 INFO - Return code: 0 05:49:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdf1890f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a758d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b04760>, '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 0x2b05660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b05af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:49:18 INFO - Using env: {'DISPLAY': ':0', 05:49:18 INFO - 'HOME': '/home/cltbld', 05:49:18 INFO - 'LANG': 'en_US.UTF-8', 05:49:18 INFO - 'LANGUAGE': 'en_US:en', 05:49:18 INFO - 'LOGNAME': 'cltbld', 05:49:18 INFO - 'MAIL': '/var/mail/cltbld', 05:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:18 INFO - 'MOZ_NO_REMOTE': '1', 05:49:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:18 INFO - 'NO_EM_RESTART': '1', 05:49:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:18 INFO - 'PWD': '/builds/slave/test', 05:49:18 INFO - 'SHELL': '/bin/bash', 05:49:18 INFO - 'SHLVL': '1', 05:49:18 INFO - 'TERM': 'linux', 05:49:18 INFO - 'TMOUT': '86400', 05:49:18 INFO - 'USER': 'cltbld', 05:49:18 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452', 05:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:18 INFO - '_': '/tools/buildbot/bin/python'} 05:49:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:49:18 INFO - Cleaning up... 05:49:18 INFO - Return code: 0 05:49:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdf1890f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a758d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b04760>, '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 0x2b05660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b05af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:49:18 INFO - Using env: {'DISPLAY': ':0', 05:49:18 INFO - 'HOME': '/home/cltbld', 05:49:18 INFO - 'LANG': 'en_US.UTF-8', 05:49:18 INFO - 'LANGUAGE': 'en_US:en', 05:49:18 INFO - 'LOGNAME': 'cltbld', 05:49:18 INFO - 'MAIL': '/var/mail/cltbld', 05:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:18 INFO - 'MOZ_NO_REMOTE': '1', 05:49:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:18 INFO - 'NO_EM_RESTART': '1', 05:49:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:18 INFO - 'PWD': '/builds/slave/test', 05:49:18 INFO - 'SHELL': '/bin/bash', 05:49:18 INFO - 'SHLVL': '1', 05:49:18 INFO - 'TERM': 'linux', 05:49:18 INFO - 'TMOUT': '86400', 05:49:18 INFO - 'USER': 'cltbld', 05:49:18 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452', 05:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:18 INFO - '_': '/tools/buildbot/bin/python'} 05:49:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:18 INFO - Downloading/unpacking blobuploader==1.2.4 05:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:20 INFO - Downloading blobuploader-1.2.4.tar.gz 05:49:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:49:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:49:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:21 INFO - Downloading docopt-0.6.1.tar.gz 05:49:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:49:21 INFO - Installing collected packages: blobuploader, requests, docopt 05:49:21 INFO - Running setup.py install for blobuploader 05:49:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:49:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:49:21 INFO - Running setup.py install for requests 05:49:21 INFO - Running setup.py install for docopt 05:49:21 INFO - Successfully installed blobuploader requests docopt 05:49:21 INFO - Cleaning up... 05:49:21 INFO - Return code: 0 05:49:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdf1890f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a758d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b04760>, '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 0x2b05660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b05af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:49:21 INFO - Using env: {'DISPLAY': ':0', 05:49:21 INFO - 'HOME': '/home/cltbld', 05:49:21 INFO - 'LANG': 'en_US.UTF-8', 05:49:21 INFO - 'LANGUAGE': 'en_US:en', 05:49:21 INFO - 'LOGNAME': 'cltbld', 05:49:21 INFO - 'MAIL': '/var/mail/cltbld', 05:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:21 INFO - 'MOZ_NO_REMOTE': '1', 05:49:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:21 INFO - 'NO_EM_RESTART': '1', 05:49:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:21 INFO - 'PWD': '/builds/slave/test', 05:49:21 INFO - 'SHELL': '/bin/bash', 05:49:21 INFO - 'SHLVL': '1', 05:49:21 INFO - 'TERM': 'linux', 05:49:21 INFO - 'TMOUT': '86400', 05:49:21 INFO - 'USER': 'cltbld', 05:49:21 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452', 05:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:21 INFO - '_': '/tools/buildbot/bin/python'} 05:49:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:22 INFO - Running setup.py (path:/tmp/pip-B1GyUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:22 INFO - Running setup.py (path:/tmp/pip-wjKerG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:22 INFO - Running setup.py (path:/tmp/pip-BWN88i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:22 INFO - Running setup.py (path:/tmp/pip-lWQycu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:22 INFO - Running setup.py (path:/tmp/pip-0_hjed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:22 INFO - Running setup.py (path:/tmp/pip-y2gHFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:22 INFO - Running setup.py (path:/tmp/pip-Fks4gP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:22 INFO - Running setup.py (path:/tmp/pip-2DThEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:22 INFO - Running setup.py (path:/tmp/pip-lzVZUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:22 INFO - Running setup.py (path:/tmp/pip-dOsrSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:22 INFO - Running setup.py (path:/tmp/pip-48eSyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:22 INFO - Running setup.py (path:/tmp/pip-j7o932-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:22 INFO - Running setup.py (path:/tmp/pip-cZ4uqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:22 INFO - Running setup.py (path:/tmp/pip-xyLCgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:23 INFO - Running setup.py (path:/tmp/pip-ajp55X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:23 INFO - Running setup.py (path:/tmp/pip-WPvbVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:23 INFO - Running setup.py (path:/tmp/pip-Fuy9nQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:49:23 INFO - Running setup.py install for manifestparser 05:49:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:49:23 INFO - Running setup.py install for mozcrash 05:49:23 INFO - Running setup.py install for mozdebug 05:49:23 INFO - Running setup.py install for mozdevice 05:49:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:49:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:49:23 INFO - Running setup.py install for mozfile 05:49:23 INFO - Running setup.py install for mozhttpd 05:49:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:49:23 INFO - Running setup.py install for mozinfo 05:49:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:49:23 INFO - Running setup.py install for mozInstall 05:49:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:49:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:49:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:49:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:49:24 INFO - Running setup.py install for mozleak 05:49:24 INFO - Running setup.py install for mozlog 05:49:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:49:24 INFO - Running setup.py install for moznetwork 05:49:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:49:24 INFO - Running setup.py install for mozprocess 05:49:24 INFO - Running setup.py install for mozprofile 05:49:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:49:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:49:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:49:24 INFO - Running setup.py install for mozrunner 05:49:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:49:24 INFO - Running setup.py install for mozscreenshot 05:49:24 INFO - Running setup.py install for moztest 05:49:24 INFO - Running setup.py install for mozversion 05:49:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:49:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:49:25 INFO - Cleaning up... 05:49:25 INFO - Return code: 0 05:49:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdf1890f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a758d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b04760>, '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 0x2b05660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b05af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:49:25 INFO - Using env: {'DISPLAY': ':0', 05:49:25 INFO - 'HOME': '/home/cltbld', 05:49:25 INFO - 'LANG': 'en_US.UTF-8', 05:49:25 INFO - 'LANGUAGE': 'en_US:en', 05:49:25 INFO - 'LOGNAME': 'cltbld', 05:49:25 INFO - 'MAIL': '/var/mail/cltbld', 05:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:25 INFO - 'MOZ_NO_REMOTE': '1', 05:49:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:25 INFO - 'NO_EM_RESTART': '1', 05:49:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:25 INFO - 'PWD': '/builds/slave/test', 05:49:25 INFO - 'SHELL': '/bin/bash', 05:49:25 INFO - 'SHLVL': '1', 05:49:25 INFO - 'TERM': 'linux', 05:49:25 INFO - 'TMOUT': '86400', 05:49:25 INFO - 'USER': 'cltbld', 05:49:25 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452', 05:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:25 INFO - '_': '/tools/buildbot/bin/python'} 05:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:25 INFO - Running setup.py (path:/tmp/pip-8qE2Kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:25 INFO - Running setup.py (path:/tmp/pip-nBPhn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:25 INFO - Running setup.py (path:/tmp/pip-ZXTg22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:25 INFO - Running setup.py (path:/tmp/pip-FLlHJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:25 INFO - Running setup.py (path:/tmp/pip-X0qn69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:25 INFO - Running setup.py (path:/tmp/pip-feZgvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:25 INFO - Running setup.py (path:/tmp/pip-NCYXn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:25 INFO - Running setup.py (path:/tmp/pip-RQ687S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:25 INFO - Running setup.py (path:/tmp/pip-VrpORu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:25 INFO - Running setup.py (path:/tmp/pip-Kv3p0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:25 INFO - Running setup.py (path:/tmp/pip-GDZu8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:26 INFO - Running setup.py (path:/tmp/pip-uQax4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:26 INFO - Running setup.py (path:/tmp/pip-TUZ1t8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:26 INFO - Running setup.py (path:/tmp/pip-c9Juye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:26 INFO - Running setup.py (path:/tmp/pip-H67DR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:26 INFO - Running setup.py (path:/tmp/pip-PINVBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:26 INFO - Running setup.py (path:/tmp/pip-sDfsL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:49:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:28 INFO - Downloading blessings-1.6.tar.gz 05:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:49:28 INFO - Installing collected packages: blessings 05:49:28 INFO - Running setup.py install for blessings 05:49:28 INFO - Successfully installed blessings 05:49:28 INFO - Cleaning up... 05:49:28 INFO - Return code: 0 05:49:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:49:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:28 INFO - Reading from file tmpfile_stdout 05:49:28 INFO - Current package versions: 05:49:28 INFO - argparse == 1.2.1 05:49:28 INFO - blessings == 1.6 05:49:28 INFO - blobuploader == 1.2.4 05:49:28 INFO - docopt == 0.6.1 05:49:28 INFO - functools32 == 3.2.3-2 05:49:28 INFO - jsonschema == 2.5.1 05:49:28 INFO - manifestparser == 1.1 05:49:28 INFO - mozInstall == 1.12 05:49:28 INFO - mozcrash == 0.17 05:49:28 INFO - mozdebug == 0.1 05:49:28 INFO - mozdevice == 0.48 05:49:28 INFO - mozfile == 1.2 05:49:28 INFO - mozhttpd == 0.7 05:49:28 INFO - mozinfo == 0.9 05:49:28 INFO - mozleak == 0.1 05:49:28 INFO - mozlog == 3.3 05:49:28 INFO - moznetwork == 0.27 05:49:28 INFO - mozprocess == 0.23 05:49:28 INFO - mozprofile == 0.28 05:49:28 INFO - mozrunner == 6.12 05:49:28 INFO - mozscreenshot == 0.1 05:49:28 INFO - mozsystemmonitor == 0.3 05:49:28 INFO - moztest == 0.7 05:49:28 INFO - mozversion == 1.4 05:49:28 INFO - psutil == 3.1.1 05:49:28 INFO - requests == 1.2.3 05:49:28 INFO - wsgiref == 0.1.2 05:49:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdf1890f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a758d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b04760>, '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 0x2b05660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b05af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:49:28 INFO - Using env: {'DISPLAY': ':0', 05:49:28 INFO - 'HOME': '/home/cltbld', 05:49:28 INFO - 'LANG': 'en_US.UTF-8', 05:49:28 INFO - 'LANGUAGE': 'en_US:en', 05:49:28 INFO - 'LOGNAME': 'cltbld', 05:49:28 INFO - 'MAIL': '/var/mail/cltbld', 05:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:28 INFO - 'MOZ_NO_REMOTE': '1', 05:49:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:28 INFO - 'NO_EM_RESTART': '1', 05:49:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:28 INFO - 'PWD': '/builds/slave/test', 05:49:28 INFO - 'SHELL': '/bin/bash', 05:49:28 INFO - 'SHLVL': '1', 05:49:28 INFO - 'TERM': 'linux', 05:49:28 INFO - 'TMOUT': '86400', 05:49:28 INFO - 'USER': 'cltbld', 05:49:28 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452', 05:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:28 INFO - '_': '/tools/buildbot/bin/python'} 05:49:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:49:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:49:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:49:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:49:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:49:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:49:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:49:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:49:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:49:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:49:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:49:29 INFO - Cleaning up... 05:49:29 INFO - Return code: 0 05:49:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdf1890f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a758d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b04760>, '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 0x2b05660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b05af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:49:29 INFO - Using env: {'DISPLAY': ':0', 05:49:29 INFO - 'HOME': '/home/cltbld', 05:49:29 INFO - 'LANG': 'en_US.UTF-8', 05:49:29 INFO - 'LANGUAGE': 'en_US:en', 05:49:29 INFO - 'LOGNAME': 'cltbld', 05:49:29 INFO - 'MAIL': '/var/mail/cltbld', 05:49:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:29 INFO - 'MOZ_NO_REMOTE': '1', 05:49:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:29 INFO - 'NO_EM_RESTART': '1', 05:49:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:29 INFO - 'PWD': '/builds/slave/test', 05:49:29 INFO - 'SHELL': '/bin/bash', 05:49:29 INFO - 'SHLVL': '1', 05:49:29 INFO - 'TERM': 'linux', 05:49:29 INFO - 'TMOUT': '86400', 05:49:29 INFO - 'USER': 'cltbld', 05:49:29 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452', 05:49:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:29 INFO - '_': '/tools/buildbot/bin/python'} 05:49:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:49:29 INFO - Cleaning up... 05:49:29 INFO - Return code: 0 05:49:29 INFO - Running post-action listener: _resource_record_post_action 05:49:29 INFO - Running post-action listener: _start_resource_monitoring 05:49:29 INFO - Starting resource monitoring. 05:49:29 INFO - [mozharness: 2016-09-03 12:49:29.332068Z] Finished create-virtualenv step (success) 05:49:29 INFO - [mozharness: 2016-09-03 12:49:29.332532Z] Running install step. 05:49:29 INFO - Running pre-action listener: _resource_record_pre_action 05:49:29 INFO - Running main action method: install 05:49:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:29 INFO - Reading from file tmpfile_stdout 05:49:29 INFO - Detecting whether we're running mozinstall >=1.0... 05:49:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:49:29 INFO - Reading from file tmpfile_stdout 05:49:29 INFO - Output received: 05:49:29 INFO - Usage: mozinstall [options] installer 05:49:29 INFO - Options: 05:49:29 INFO - -h, --help show this help message and exit 05:49:29 INFO - -d DEST, --destination=DEST 05:49:29 INFO - Directory to install application into. [default: 05:49:29 INFO - "/builds/slave/test"] 05:49:29 INFO - --app=APP Application being installed. [default: firefox] 05:49:29 INFO - mkdir: /builds/slave/test/build/application 05:49:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:49:46 INFO - Reading from file tmpfile_stdout 05:49:46 INFO - Output received: 05:49:46 INFO - /builds/slave/test/build/application/firefox/firefox 05:49:46 INFO - Running post-action listener: _resource_record_post_action 05:49:46 INFO - [mozharness: 2016-09-03 12:49:46.637376Z] Finished install step (success) 05:49:46 INFO - [mozharness: 2016-09-03 12:49:46.637656Z] Running run-tests step. 05:49:46 INFO - Running pre-action listener: _resource_record_pre_action 05:49:46 INFO - Running main action method: run_tests 05:49:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:49:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:49:46 INFO - Python 2.7.3 05:49:46 INFO - Return code: 0 05:49:46 INFO - grabbing minidump binary from tooltool 05:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:46 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 0x2b04760>, '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 0x2b05660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b05af0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:49:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:49:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:49:46 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:49:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:49:46 INFO - Return code: 0 05:49:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:49:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:49:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:49:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:49:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:49:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:49:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:49:46 INFO - Using env: {'DISPLAY': ':0', 05:49:46 INFO - 'HOME': '/home/cltbld', 05:49:46 INFO - 'LANG': 'en_US.UTF-8', 05:49:46 INFO - 'LANGUAGE': 'en_US:en', 05:49:46 INFO - 'LOGNAME': 'cltbld', 05:49:46 INFO - 'MAIL': '/var/mail/cltbld', 05:49:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:49:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:46 INFO - 'MOZ_NO_REMOTE': '1', 05:49:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:49:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:46 INFO - 'NO_EM_RESTART': '1', 05:49:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:46 INFO - 'PWD': '/builds/slave/test', 05:49:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:49:46 INFO - 'SHELL': '/bin/bash', 05:49:46 INFO - 'SHLVL': '1', 05:49:46 INFO - 'TERM': 'linux', 05:49:46 INFO - 'TMOUT': '86400', 05:49:46 INFO - 'USER': 'cltbld', 05:49:46 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452', 05:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:46 INFO - '_': '/tools/buildbot/bin/python'} 05:49:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:49:46 INFO - mozversion application_buildid: 20160903030202 05:49:46 INFO - mozversion application_changeset: d0830980ffdb36a10855d02a588b4869cad6707e 05:49:46 INFO - mozversion application_display_name: Nightly 05:49:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:49:46 INFO - mozversion application_name: Firefox 05:49:46 INFO - mozversion application_remotingname: firefox 05:49:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:49:46 INFO - mozversion application_vendor: Mozilla 05:49:46 INFO - mozversion application_version: 51.0a1 05:49:46 INFO - mozversion platform_buildid: 20160903030202 05:49:46 INFO - mozversion platform_changeset: d0830980ffdb36a10855d02a588b4869cad6707e 05:49:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:49:46 INFO - mozversion platform_version: 51.0a1 05:49:46 INFO - using testdate: 1472906986 05:49:46 INFO - actual date: 1472906986 05:49:46 INFO - starting webserver on 'localhost:33241' 05:49:46 INFO - SUITE-START | Running 2 tests 05:49:46 INFO - TEST-START | dromaeo_css 05:49:46 INFO - operating with platform_type : linux_ 05:49:46 INFO - Initialising browser for dromaeo_css test... 05:49:46 INFO - TEST-INFO | started process 23630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpurs0bv/profile http://localhost:33241/getInfo.html) 05:49:50 INFO - PROCESS | 23630 | __metrics Screen width/height:1600/1200 05:49:50 INFO - PROCESS | 23630 | colorDepth:24 05:49:50 INFO - PROCESS | 23630 | Browser inner width/height: 1024/697 05:49:50 INFO - PROCESS | 23630 | __metrics 05:49:51 INFO - PROCESS | 23630 | 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" 05:49:51 INFO - PROCESS | 23630 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:49:51 INFO - PROCESS | 23630 | console.error: PushService: 05:49:51 INFO - PROCESS | 23630 | stateChangeProcessEnqueue: Error transitioning state 05:49:51 INFO - PROCESS | 23630 | UnknownError 05:49:52 INFO - TEST-INFO | 23630: exit 0 05:49:52 INFO - Browser initialized. 05:49:52 INFO - Running cycle 1/1 for dromaeo_css test... 05:49:52 INFO - TEST-INFO | started process 23711 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpurs0bv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:04 INFO - PROCESS | 23711 | RSS: Main: 179511296 05:50:04 INFO - PROCESS | 23711 | 05:50:56 INFO - PROCESS | 23711 | 1472907056206 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:53:05 INFO - PROCESS | 23711 | Cycle 1(1): loaded http://localhost:33241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33241/tests/dromaeo/cssquery-ext.html) 05:53:06 INFO - PROCESS | 23711 | RSS: Main: 290254848 05:53:06 INFO - PROCESS | 23711 | 05:56:08 INFO - PROCESS | 23711 | Cycle 1(1): loaded http://localhost:33241/tests/dromaeo/cssquery-ext.html (next: http://localhost:33241/tests/dromaeo/cssquery-jquery.html) 05:56:08 INFO - PROCESS | 23711 | RSS: Main: 277729280 05:56:08 INFO - PROCESS | 23711 | 05:59:10 INFO - PROCESS | 23711 | Cycle 1(1): loaded http://localhost:33241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33241/tests/dromaeo/cssquery-mootools.html) 05:59:11 INFO - PROCESS | 23711 | RSS: Main: 214962176 05:59:11 INFO - PROCESS | 23711 | 06:02:13 INFO - PROCESS | 23711 | Cycle 1(1): loaded http://localhost:33241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33241/tests/dromaeo/cssquery-prototype.html) 06:02:14 INFO - PROCESS | 23711 | RSS: Main: 258277376 06:02:14 INFO - PROCESS | 23711 | 06:05:17 INFO - PROCESS | 23711 | Cycle 1(1): loaded http://localhost:33241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33241/tests/dromaeo/cssquery-yui.html) 06:05:17 INFO - PROCESS | 23711 | RSS: Main: 215744512 06:05:17 INFO - PROCESS | 23711 | 06:08:20 INFO - PROCESS | 23711 | Cycle 1(1): loaded http://localhost:33241/tests/dromaeo/cssquery-yui.html (next: http://localhost:33241/tests/dromaeo/cssquery-dojo.html) 06:08:20 INFO - PROCESS | 23711 | RSS: Main: 309989376 06:08:20 INFO - PROCESS | 23711 | 06:08:20 INFO - PROCESS | 23711 | __start_tp_report 06:08:20 INFO - PROCESS | 23711 | _x_x_mozilla_page_load 06:08:20 INFO - PROCESS | 23711 | _x_x_mozilla_page_load_details 06:08:20 INFO - PROCESS | 23711 | |i|pagename|runs| 06:08:20 INFO - PROCESS | 23711 | |0;dojo.html;2947.6904924982878;2955.4089182163566;2969.406118776244;2999.5050816615258;3026.394721055788;5025.974870125644;5100.846974590759;5155.510226528479;5221.216817477381;5238.738063096849;5167.7932882684745;5195.948040519594;5240.973795131019;5249.396319423267;5269.86825329367;4652.232381657022;4704.764761761915;4712.5523075307965;4724.291356296549;4890.046440944017;4805.351277577534;4834.782434790425;4848.854534363974;4852.975735121319;4885.8778530536665;4656.790444429992;4672.15901137795;4709.293605959134;4738.24188129901;4768.90462190756;4707.270373092176;4707.45864225615;4726.1020406122725;4738.928916066262;4791.856244312677;4726.385569875929;4755.548222918817;4758.191107511697;4800.687955282895;4813.940932994736;5019.247112933052;5150.3047088642925;5215.739213039333;5230.08473517133;5252.0283747506455;5530.668159910378;5545.889082218373;5577.498025177713;5585.357683866326;5640.097584386478;5570.888582228374;5603.691796951166;5611.971940140274;5617.494425501724;5618.297712785902;5074.441811400743;5127.051495473312;5149.407818100892;5159.896802063938;5204.609654275944;5629.352624448241;5633;5636.689982051026;5638.689872056994;5698.202251684767;5440.591955603346;5446.101393270145;5447.319085114361;5450.264214331015;5450.591205659592;5332.600054995891;5422.322209723785;5461.617686761889;5467.835964921059;5499.1476321170285;5469.671819690831;5470.288862447936;5471.288732464834;5474.288342515448;5521.420250873681;5484.61607687458;5489.6980666062955;5493.368262649767;5495.203195536705;5558.749856256478;4223.345381465878;4225.302825033897;4283.357496375568;4284.357346398066;4292.828286868553;3816.961830381716;3823.3882578787816;3859.5754467008605;3860.2279544091293;3876.8061596920606;5184.170532714823;5192.636515443958;5194.714290713971;5195.116830138885;5255.290535777697;5313.415524292324;5467.507924286833;5505.504504594605;5507.642003269774;5547.55619550435;5219.817306394258;5224.817131400383;5286.7092309922555;5290.576753859682;5306.973465132727;4829.1307564638;4842.297866809293;4877.3903262092235;4884.804607815719;4942.406911170682;5557.194206840067;5772.7690892363835;5773.566982476331;5782.855428614318;5783.566232532577;5486.862828429162;5519.227308176778;5544.667319960815;5548.445155484419;5617.045102332695;5698;5698.715064246854;5700.629459085146;5705.686187259741;5707.343655479673;5316.441773613715;5412.83761487156;5429.918551221655;5433.508130304299;5434.402215756343;5478.616496845182;5529.944700552943;5532.889342213214;5549.72251387421;5637.46444087811;5385.192221166856;5417.702026388586;5435.076037073786;5447.918281225706;5448.618596698193;5318.441563635763;5399.969131653423;5436.103042998019;5442.074847275893;5514.255575497256;5341.5459685927135;5388.110961691434;5388.353397592314;5405.5135037846785;5471.671699698031;5461.044317244387;5494.587905907153;5500.9174862377895;5506.146547285177;5507.284053073075;5230.084735171406;5241.659292146151;5373.2746079278795;5381.058314794817;5437.592180586393 06:08:20 INFO - PROCESS | 23711 | |1;ext.html;555.6923986403272;587.8324677466923;612.5926259037743;614.4377894226783;630.3727790848106;43079;44258.33612495815;44521.554784452106;44615;48164.27753583699;45676.314855277116;45793;45880.31179532301;46120;46162.76918615411;9005.729828105152;9147.771305717377;9156.221721153677;9156.679516216935;9158.221551168159;8961.551922403887;9020.819583608323;9046.592903319333;9047.819043619123;9048.185663290302;9024.142706442877;9071.410358326688;9080.500572468512;9080.954595227015;9081;8976.640934362651;8997.190252877239;9005.414648047856;9005.729828105168;9014.368994170378;8992.775180620536;9048.638054477813;9059.909400905972;9070.591823367964;9074.274058075338;42748.78625606852;43130.56869431297;43141.98006139571;43146.78426607878;43148.137037259075;3444.7588668793196;3570.357335679577;3586.37238483267;3588.4258518637153;3671.229041901204;32636.67363326384;32881.177970550685;32922;32944.1763955903;33076;4398.912021759579;4523.7285762854335;4550.089982003613;4606.723596584216;4636.652251081183;338215;338581;339922;340692;341059.29470352735;57129;57771.42228577661;57791.711041445364;57855.42144578585;57860.13209801856;61276;61311;61317;61400;61471;15978.76031859523;16390.26243819031;16394.918025410036;16395.754063689055;16396.09821459831;12404.25574465535;12603.495860165674;12629.747405051847;12638.810417843555;12642.747145057047;15784.763228551581;16977.575560611083;17097.145142743062;17099.91450042767;17435.302587896596;5763.164341170507;5765.308163020464;5797.275340582427;5818.738156782955;5899.646021238739;893.584483215308;1021.6883850425543;1025.4565080507343;1026.7741096958657;1127.3067063755896;31807.522887156712;32027;32180.35639287248;32306;32699.83650081782;1051.2115913065202;1076.7900259449332;1079.266099052636;1110.4725255503572;1176.817593273044;16028;16675.166241687868;16767;16931;16933.407330743365;508392;512986;513876;514012;515272;57933.420665793645;58271.41728582745;58296.70851645715;58332.41667583355;58348.416515834295;1274.388293619068;1329.9667508312175;1334.1394800353912;1342.3020029584561;1354.844192917827;29748.335962066125;31963;32030.839845800623;32097.679023209468;32532.72270941106;51102;51484.227736583234;51688.74155629198;51806;51848.222276665125;348074;348078.1921807799;348856;348964;350695;27564.58653120245;28262.15213543597;28354.574681379385;29978.85010574933;41618.79190604028;46982.530174697815;47158.76420617875;47426.28860567163;47647.52352476431;48958.26562601635;39294.214115718096;40039.1992160161;40518.79740601278;40561.391579125746;42293;39930.11561609159;40624;40878.38682419826;41224.38163427491;41552.376714348706;39797.60202397939;40059;40373;40650;41285.79357103195;33090;35289.82355088208;36296.637033629326;36418;36556.26887462183;27574.310642234104;27763.583546247228;27789.722102778713;28100.859495702392;28103.71896281011 06:08:20 INFO - PROCESS | 23711 | |2;jquery.html;367.5350681388043;379.7360834220218;388.8464056697604;395.8752992807266;417.1177958617523;16483.670326593478;18933.538639976818;18937;19124.426267211988;19314.61370772587;17733.7339939901;18233.726494102564;18267.08664566773;18710.25158993642;18711.53221169468;5291.788328466857;5413.566914646819;5416.91874621881;5420.566354691615;5493.478119578634;5720.485156335929;5843.298804143508;5848.41515848416;5851.414858514136;5854.063349864023;5353.357597088355;5390.460953904618;5817.272840894888;5819.33077696064;5819.53443724501;5274.235235890813;5306.283651707028;5310.309659744247;5314.627976041678;5353.464653534635;5072.264521644341;5101;5161.3806343238675;5174.922376164361;5265.921011184835;14242;14419.927900360432;18206.726899096524;22957;23197.304080877602;2281.9657705134437;2299.908003679851;2364.1725396111224;2381.773731495505;2386.3914701751114;10372.585096596127;10595;10891.509882055327;11016.834747478793;12224.205426647239;1909.7230901519201;1980.7722111957166;1985.8510611704035;1987.691907754286;2037.1851259496173;79017.60491197507;81857.59071204666;82760.58619706862;82877.58561207155;83386;10138.442385668712;10388.37669739818;10468.738281543023;11085.279456835442;12122.09084318662;15487.5353739388;15944.601384965468;15964.521064368088;15979.280932358071;15989.12059836697;7933.087694915159;8054.637541310655;8154.5514996674565;8337.332053742866;8399.328053755686;7609.315161635479;7652.655630496641;7666.9616651917495;7865.685372585147;7937.761867143995;4768;4837.346958160673;4851.34506841579;4975.601951843843;4984.626153038536;1921.3275353626118;1935.2742721479444;1969.2713695932596;2018.7476565429322;2031.4616626593966;926.8517037274004;992.300428198133;1028.7942411517577;1031.185363562792;1067.631667074858;19051.61896762057;19448.4165475036;19758.70361944572;19791.802081979284;20145.093470793556;911.8221946720458;939.0515579264992;958.496789185683;967.7919247361851;1022.4070039377292;10067.69796906094;10574.89425105739;10739.248252622241;10761.300515466626;10802.567897284178;447492;451919;452275;473805;475702;92606;92714.53642731743;92852;93669.5316523413;94020;999;1037.725002874239;1056.5034433816095;1059.4067322299536;1068.5512084924194;16580.917095414447;16674.249658765628;17204;17441.56396090057;17847.821521785136;38336.42495362516;39852.2029559413;43186;44005.77997109994;45135.54864451445;56805.71597141988;58079.12881306699;58516.4148358528;58746.41909018636;59435.40564594472;8290.253877151084;8319.708810191614;8402.201790829862;8491.702790402307;9107.908920910706;10473.842892356468;13161.670958226121;13308.800367994294;13311.00167487423;13344.132631378929;11449.942750286194;11606.303621782383;11615.36115513621;11983.400829958642;12252.754944900873;11336.886631133582;11389.202755807346;11908.225965312227;11913.285202887855;12149.271043737404;11789.351585662871;11982.281063136239;12089.15375923712;12165.270083795001;12220.572279970158;7622;8455.66177352899;8711.869321960303;8974.775630609287;8975.50634715097;10216.284860059724;11690.123240756808;11863.822042669195;11866;12185 06:08:20 INFO - PROCESS | 23711 | |3;mootools.html;1256.9497220111195;1471.440852476059;1506.6685329227569;1657.7679124922506;1812.2479171143975;8723.258523025543;9190.81618367633;9210.217131543826;9221.7694557636;9225.169734723873;9082.182603565694;9179.219766319855;9190.770230744234;9203.401778884385;9206.677766278182;2033.8372930165626;2262.9207977720785;2350.9294721158394;2373.1338061607476;2373.2168384433094;2353.52929414117;2375.2755409600063;2381.249906279525;2386.343755467243;2386.916457923973;2285.1773361589812;2287.142321629389;2336.836421450499;2394.2338451695464;2399.0763556030965;2003.3088584438347;2199.681046248285;2261.31030035839;2269.931902042941;2305.319930620471;2299.724033116037;2331.0093210385517;2340.6840076589615;2341.110378056345;2343.61330380487;8919.598618062202;8980.19178273952;8995.910040899638;8995.955020224923;9004.369694121415;5206.635535512516;5336.866578335573;5346.144616861284;5354.116570765819;5355.892882142374;3070.1250143708935;3173.5557022016937;3349.8492567834264;3370.4607262837826;3370.69663730263;1144.5765066925292;1155.1163360029584;1165.5745652836738;1178.4166837415448;1181.1377694283135;12311.19977201488;12410.503579856795;12535.122541422104;12539.310337931502;12541.498340066386;4458.509563947963;4569.360289559464;4700.412448443944;4731.881702957454;4769.236922092448;10596.576136954589;10694.625688101034;10699.465026748632;10703.090237329914;10713.410762407986;5281.445448227958;5305.575553955674;5307.071262529042;5307.230451584499;5312.362516498045;4173.373993900878;4731.52684731531;4838.685485443435;4856.781444834991;4858.708477491362;4090.6931980101017;4119.941254850858;4188.560201178832;4208.179405015992;4220.936685949713;1227.5212667059855;1304.1523010043359;1309.2798960571647;1315.8684131586956;1329.5678904356123;911.9544022798833;930.4603330068544;931.5668214280392;939.3987847777428;946.1201082992745;5557.666540007613;5750.856228594235;5821.417858214145;5939.990201665727;6063.636181829104;934.1499235695485;959.2589450147959;959.7456673981401;962.1773383756787;965.7199412170391;3681.834317455721;3816.923661526754;3843.577206507282;3855.7879316637855;3914.8434062637743;11092;11533.250338727956;11586.76826463483;11594.536218551164;11594.594189203506;11146.21976461656;11293.153013523854;11446.19876608646;11476.713082172846;11527.365994870363;8455.365847561457;8595.527246001406;8598.398112132216;8600.827983440297;8604.741857744402;5605.635633683797;5744.511716504144;5746.454086861741;5836.503897168788;5976.671283079472;10404.271700981162;10432.947835260775;10489.790204196026;10530.631427899987;10576.576936922436;10096.091351778376;10464.686059417925;10469.895301046892;10484.842727359248;10568.154547636324;7691.30778229962;7916.456291023425;7921.2870841622225;8360.331173505983;8545.786355341166;8038.557879316693;8503;8682.78293042679;8765.07966663491;8772.210501054935;7689.653965571674;7732.690692372467;7966.960165199137;8066.435349525712;8149.225823546753;7555.924440755742;7651.387888968758;7669.501482403626;7713.730019449293;7893.57915575202;7309.086364204474;7433.442491813244;7448.329650331496;7454.142773581108;7457.366123879531;5186;5301.575873929999;5373.704446255493;5436.7281635918835;5522.0336441121835;5192.532672059533;5318.388385335581;5340.572754179579;5376.516113549643;5387.973060134675 06:08:20 INFO - PROCESS | 23711 | |4;prototype.html;317.6489978573675;325.9006003169034;326.0641957581741;333.77970539443965;334.63859032245176;5047.77285022174;5088.949110508894;5224.268602395668;5316.20256961456;5339.2113641929955;5152.604039121808;5161.9483805162035;5166.741662916858;5185.248139019849;5208.140656791635;4128.876133715993;4131.73143745657;4134.627883490492;4149.564295748948;4157.542670306279;3973.6622387096986;4099.405586190001;4148.522919864209;4148.605882441163;4161.417401563784;4058.7564746115327;4061.1877624475073;4070.694697897655;4079.2045551117544;4086.4483294755273;4047.372657238118;4055.3105971984833;4055.4119652650347;4071.6335529802163;4077.571854955246;3454.3954807908517;3551.3607550640872;3561.928761424783;3575.6424357564297;3613.7109031277696;5004.699718016931;5006.774695138727;5020.899582008339;5021.799128034874;5035.370578677665;4542.545745425464;4568.223402021665;4595.149897269016;4601.930971035437;4608.861734147981;5167.896642067175;5340.198970154469;5351.518363347279;5364.785408583691;5413.998410294108;3906.335922893115;3911.2959667259884;3912.6478616924614;3919.7844118573466;3921.156951255494;5595.916061259084;5634.605577609569;5644.181593668895;5652.34997975234;5656.2929633795775;3906.8046597670004;4006.8397264109694;4007.4971885542923;4010.27814993304;4014.9360419488858;4026.4966879140106;4031.576684448091;4044;4047.461964453548;4047.494063242095;4610.469795973506;4614.930776038362;4626.653001024869;4627.722336659811;4628.431220672559;5233.110371236899;5425.755840987165;5426.9185962210595;5452.645578037414;5475.233467314579;1376.9931150344185;1397.6156556946717;1398.3148257354026;1400.43982407038;1403.1440821099122;866.9033672404413;901.085398320705;911.2072496927715;912.5665308978315;926.5598840550684;4632.726000349863;4634.58645113237;4642.628589712815;4642.632257548607;4650.813967441264;4848;4919.754012299442;4929.630277729185;4970.826021089245;4999.675021123688;4501.6848820582245;4727.101850648366;4728.574428301401;4729.929051064237;4735.337052812609;2618.6988496323165;2633.5391306521283;2655.7078721340636;2658.5909467981614;2670.492606404777;5078.984203159383;5102.540771330598;5128.615353848476;5152.562032227228;5169.405518365361;4679.321498382716;4980.800767969313;5011.34852469184;5093.796248150106;5132.307138536325;5050.368703912011;5108.540231379194;5113.335266415416;5118.769655365592;5131.87170320745;4919.778609962632;4932.630052745986;4952.975235123801;4962.429320628174;4972.254161875603;4894.675029361025;4896.4124305083615;4913.263010548446;5074.847754567369;5546.696526316393;5702;5732.856678582902;5734.90675903284;5763.242211125479;5772.422757724194;3856.9614303857725;3970.7220494565104;3991.7426010806503;3994.141259629194;4025.335819589735;5523.751431185526;5555.694436805853;5599.188117722989;5610.9158362623775;5621.269234999424;5481.369642491005;5493.176023596492;5504.366997795145;5506;5507.669539827623;5268.2361057647195;5429.782808687608;5432.696152923349;5437.293151890229;5456.417638884837;5383.219433182245;5392.946070539245;5404.702741349263;5425.647332923348;5447.945520544744;5289.285946397187;5451;5484.396716361117;5486.149646804752;5543.805966791143;5319.867003324948;5325.893482130258;5338.225957236102;5341.786328546815;5390.218418329398 06:08:20 INFO - PROCESS | 23711 | |5;yui.html;753.5554023126355;810.0926961802782;814.6822739131738;820.2822530285999;825.9421840471169;15606.453774117908;15709.528714138594;16143.677126457464;16655.500334989956;16668.416605418814;14410.2074385909;14557.563273101798;14623.415063397479;14632.268386580681;14640.560783176496;658.6081281637418;789.9328557072641;804.047204063184;804.3766081287021;804.90341159061;787.8069872881152;813.8819871118684;815.4862436664893;821.6425854753171;821.8150916043902;858.7295002074358;860.3590325207729;865.8917635295588;866.0343716755804;866.3199388480044;683.5556888022775;835.2941764209233;836.506461187902;836.6862426590029;836.7113345895626;600.4385899184233;610.0513701194641;617.9814605561841;619.8140557832677;620.7672122953892;15259.313330900137;15305.693886122326;15366.769498457532;15397.615059623487;15408;13933.30333483332;14295.78556321656;14691.412343506247;14697.485588004369;14848.183349915751;13417.865821341758;13447.394867230998;13481.59555213345;13856.376463059187;13869.653258668513;4563.292689633112;4675.579197872174;4718.882027949295;4809.927851082237;4867.36724225852;82925.17074829235;83004.58497707533;83420;84633.15366846314;84638.57680711619;11588.88411115895;11671.877326187252;11754.177207595387;11907.024629761581;12357.25856448598;22262.77737222607;22462.213822516132;22486.775132248797;22492.437689057577;22602.321930342117;8801;8851.291896648252;8884.911150888409;9088.318376121817;9209.815803684023;4679.578837904605;4838.153323168502;4917.286993385939;4929.802807887644;5007.147355478423;3543.344481270973;3660.5790334111916;3672.4674922136674;3682.0978860179425;3685.4287585424304;583.8015074874563;592.9021711417568;600.7266693654377;600.945914867664;603.2640178981635;567.9260310974174;570.4381184533231;591.4647244243966;658.1772784019975;712.3837880233664;8151.30713889326;8494.74515764528;9199.95400023009;9491.335606507479;9701.90298097024;625.8497960489541;687.6767919078026;704.5490885833071;712.8431745016088;732.3884556395469;4355.324924636687;4594.862154135381;4665.011415239989;4779.139754844162;4781.737004464788;124414.14060625566;129724;130205;132490.33754831165;133547.33226334;99181.50409248052;108189;108435.83128337548;110956;112802.43598782118;95782;98204;98327;98410;98742;9706.725138913283;9733.464659443798;9826.219908263276;9966.860065881629;10175.694729158136;51951.740241298554;52538.73730631475;52590.73704631453;53407.73296133494;53642.85428582813;75328;76506.61746691231;77774.2222577767;79905.8108317551;80703;12616.116871818884;12951.805722913976;12953.481860725842;13005.349732513525;13256.07207495466;14875.256237187881;15122.924385378443;15198.240087995777;15447.768283475982;16316.755248671518;14109.235036074635;14141.222232777296;14500.129992200502;14898.25508724581;15223.391064357302;14633.926830365781;14759.557213283619;14766.63083422923;15039.548813535173;15176.620584485476;14427.639309017359;14457.638559036108;14643.85356146425;14887.330070146652;15402.075875447508;10291.228157888338;10729.731756706145;10997.12023038139;11009.229353945148;11021.393823339473;10137;10157.288989770645;10906.836397454203;11778.234414763014;12067.456964436797 06:08:20 INFO - PROCESS | 23711 | __end_tp_report 06:08:20 INFO - PROCESS | 23711 | __start_cc_report 06:08:20 INFO - PROCESS | 23711 | _x_x_mozilla_cycle_collect,949 06:08:20 INFO - PROCESS | 23711 | __end_cc_report 06:08:20 INFO - PROCESS | 23711 | __startTimestamp1472908100812__endTimestamp 06:08:20 INFO - PROCESS | 23711 | 06:08:20 INFO - PROCESS | 23711 | ------- Summary: start ------- 06:08:20 INFO - PROCESS | 23711 | Number of tests: 6 06:08:20 INFO - PROCESS | 23711 | 06:08:20 INFO - PROCESS | 23711 | [#0] dojo.html Cycles:165 Average:5154.28 Median:5373.27 stddev:570.39 (10.6%) stddev-sans-first:545.24 06:08:20 INFO - PROCESS | 23711 | Values: 2947.7 2955.4 2969.4 2999.5 3026.4 5026.0 5100.8 5155.5 5221.2 5238.7 5167.8 5195.9 5241.0 5249.4 5269.9 4652.2 4704.8 4712.6 4724.3 4890.0 4805.4 4834.8 4848.9 4853.0 4885.9 4656.8 4672.2 4709.3 4738.2 4768.9 4707.3 4707.5 4726.1 4738.9 4791.9 4726.4 4755.5 4758.2 4800.7 4813.9 5019.2 5150.3 5215.7 5230.1 5252.0 5530.7 5545.9 5577.5 5585.4 5640.1 5570.9 5603.7 5612.0 5617.5 5618.3 5074.4 5127.1 5149.4 5159.9 5204.6 5629.4 5633.0 5636.7 5638.7 5698.2 5440.6 5446.1 5447.3 5450.3 5450.6 5332.6 5422.3 5461.6 5467.8 5499.1 5469.7 5470.3 5471.3 5474.3 5521.4 5484.6 5489.7 5493.4 5495.2 5558.7 4223.3 4225.3 4283.4 4284.4 4292.8 3817.0 3823.4 3859.6 3860.2 3876.8 5184.2 5192.6 5194.7 5195.1 5255.3 5313.4 5467.5 5505.5 5507.6 5547.6 5219.8 5224.8 5286.7 5290.6 5307.0 4829.1 4842.3 4877.4 4884.8 4942.4 5557.2 5772.8 5773.6 5782.9 5783.6 5486.9 5519.2 5544.7 5548.4 5617.0 5698.0 5698.7 5700.6 5705.7 5707.3 5316.4 5412.8 5429.9 5433.5 5434.4 5478.6 5529.9 5532.9 5549.7 5637.5 5385.2 5417.7 5435.1 5447.9 5448.6 5318.4 5400.0 5436.1 5442.1 5514.3 5341.5 5388.1 5388.4 5405.5 5471.7 5461.0 5494.6 5500.9 5506.1 5507.3 5230.1 5241.7 5373.3 5381.1 5437.6 06:08:20 INFO - PROCESS | 23711 | 06:08:20 INFO - PROCESS | 23711 | [#1] ext.html Cycles:180 Average:56965.61 Median:41419.09 stddev:107975.83 (260.7%) stddev-sans-first:108195.66 06:08:20 INFO - PROCESS | 23711 | Values: 555.7 587.8 612.6 614.4 630.4 43079.0 44258.3 44521.6 44615.0 48164.3 45676.3 45793.0 45880.3 46120.0 46162.8 9005.7 9147.8 9156.2 9156.7 9158.2 8961.6 9020.8 9046.6 9047.8 9048.2 9024.1 9071.4 9080.5 9081.0 9081.0 8976.6 8997.2 9005.4 9005.7 9014.4 8992.8 9048.6 9059.9 9070.6 9074.3 42748.8 43130.6 43142.0 43146.8 43148.1 3444.8 3570.4 3586.4 3588.4 3671.2 32636.7 32881.2 32922.0 32944.2 33076.0 4398.9 4523.7 4550.1 4606.7 4636.7 338215.0 338581.0 339922.0 340692.0 341059.3 57129.0 57771.4 57791.7 57855.4 57860.1 61276.0 61311.0 61317.0 61400.0 61471.0 15978.8 16390.3 16394.9 16395.8 16396.1 12404.3 12603.5 12629.7 12638.8 12642.7 15784.8 16977.6 17097.1 17099.9 17435.3 5763.2 5765.3 5797.3 5818.7 5899.6 893.6 1021.7 1025.5 1026.8 1127.3 31807.5 32027.0 32180.4 32306.0 32699.8 1051.2 1076.8 1079.3 1110.5 1176.8 16028.0 16675.2 16767.0 16931.0 16933.4 508392.0 512986.0 513876.0 514012.0 515272.0 57933.4 58271.4 58296.7 58332.4 58348.4 1274.4 1330.0 1334.1 1342.3 1354.8 29748.3 31963.0 32030.8 32097.7 32532.7 51102.0 51484.2 51688.7 51806.0 51848.2 348074.0 348078.2 348856.0 348964.0 350695.0 27564.6 28262.2 28354.6 29978.9 41618.8 46982.5 47158.8 47426.3 47647.5 48958.3 39294.2 40039.2 40518.8 40561.4 42293.0 39930.1 40624.0 40878.4 41224.4 41552.4 39797.6 40059.0 40373.0 40650.0 41285.8 33090.0 35289.8 36296.6 36418.0 36556.3 27574.3 27763.6 27789.7 28100.9 28103.7 06:08:20 INFO - PROCESS | 23711 | 06:08:20 INFO - PROCESS | 23711 | [#2] jquery.html Cycles:180 Average:28088.51 Median:2372.97 stddev:76160.62 (3209.5%) stddev-sans-first:76345.83 06:08:20 INFO - PROCESS | 23711 | Values: 367.5 379.7 388.8 395.9 417.1 16483.7 18933.5 18937.0 19124.4 19314.6 17733.7 18233.7 18267.1 18710.3 18711.5 5291.8 5413.6 5416.9 5420.6 5493.5 5720.5 5843.3 5848.4 5851.4 5854.1 5353.4 5390.5 5817.3 5819.3 5819.5 5274.2 5306.3 5310.3 5314.6 5353.5 5072.3 5101.0 5161.4 5174.9 5265.9 14242.0 14419.9 18206.7 22957.0 23197.3 2282.0 2299.9 2364.2 2381.8 2386.4 10372.6 10595.0 10891.5 11016.8 12224.2 1909.7 1980.8 1985.9 1987.7 2037.2 79017.6 81857.6 82760.6 82877.6 83386.0 10138.4 10388.4 10468.7 11085.3 12122.1 15487.5 15944.6 15964.5 15979.3 15989.1 7933.1 8054.6 8154.6 8337.3 8399.3 7609.3 7652.7 7667.0 7865.7 7937.8 4768.0 4837.3 4851.3 4975.6 4984.6 1921.3 1935.3 1969.3 2018.7 2031.5 926.9 992.3 1028.8 1031.2 1067.6 19051.6 19448.4 19758.7 19791.8 20145.1 911.8 939.1 958.5 967.8 1022.4 10067.7 10574.9 10739.2 10761.3 10802.6 447492.0 451919.0 452275.0 473805.0 475702.0 92606.0 92714.5 92852.0 93669.5 94020.0 999.0 1037.7 1056.5 1059.4 1068.6 16580.9 16674.2 17204.0 17441.6 17847.8 38336.4 39852.2 43186.0 44005.8 45135.5 56805.7 58079.1 58516.4 58746.4 59435.4 8290.3 8319.7 8402.2 8491.7 9107.9 10473.8 13161.7 13308.8 13311.0 13344.1 11449.9 11606.3 11615.4 11983.4 12252.8 11336.9 11389.2 11908.2 11913.3 12149.3 11789.4 11982.3 12089.2 12165.3 12220.6 7622.0 8455.7 8711.9 8974.8 8975.5 10216.3 11690.1 11863.8 11866.0 12185.0 06:08:20 INFO - PROCESS | 23711 | 06:08:20 INFO - PROCESS | 23711 | [#3] mootools.html Cycles:180 Average:5926.75 Median:4750.56 stddev:3438.11 (72.4%) stddev-sans-first:3429.84 06:08:20 INFO - PROCESS | 23711 | Values: 1256.9 1471.4 1506.7 1657.8 1812.2 8723.3 9190.8 9210.2 9221.8 9225.2 9082.2 9179.2 9190.8 9203.4 9206.7 2033.8 2262.9 2350.9 2373.1 2373.2 2353.5 2375.3 2381.2 2386.3 2386.9 2285.2 2287.1 2336.8 2394.2 2399.1 2003.3 2199.7 2261.3 2269.9 2305.3 2299.7 2331.0 2340.7 2341.1 2343.6 8919.6 8980.2 8995.9 8996.0 9004.4 5206.6 5336.9 5346.1 5354.1 5355.9 3070.1 3173.6 3349.8 3370.5 3370.7 1144.6 1155.1 1165.6 1178.4 1181.1 12311.2 12410.5 12535.1 12539.3 12541.5 4458.5 4569.4 4700.4 4731.9 4769.2 10596.6 10694.6 10699.5 10703.1 10713.4 5281.4 5305.6 5307.1 5307.2 5312.4 4173.4 4731.5 4838.7 4856.8 4858.7 4090.7 4119.9 4188.6 4208.2 4220.9 1227.5 1304.2 1309.3 1315.9 1329.6 912.0 930.5 931.6 939.4 946.1 5557.7 5750.9 5821.4 5940.0 6063.6 934.1 959.3 959.7 962.2 965.7 3681.8 3816.9 3843.6 3855.8 3914.8 11092.0 11533.3 11586.8 11594.5 11594.6 11146.2 11293.2 11446.2 11476.7 11527.4 8455.4 8595.5 8598.4 8600.8 8604.7 5605.6 5744.5 5746.5 5836.5 5976.7 10404.3 10432.9 10489.8 10530.6 10576.6 10096.1 10464.7 10469.9 10484.8 10568.2 7691.3 7916.5 7921.3 8360.3 8545.8 8038.6 8503.0 8682.8 8765.1 8772.2 7689.7 7732.7 7967.0 8066.4 8149.2 7555.9 7651.4 7669.5 7713.7 7893.6 7309.1 7433.4 7448.3 7454.1 7457.4 5186.0 5301.6 5373.7 5436.7 5522.0 5192.5 5318.4 5340.6 5376.5 5388.0 06:08:20 INFO - PROCESS | 23711 | 06:08:20 INFO - PROCESS | 23711 | [#4] prototype.html Cycles:180 Average:4444.39 Median:4966.63 stddev:1282.42 (25.8%) stddev-sans-first:1248.05 06:08:20 INFO - PROCESS | 23711 | Values: 317.6 325.9 326.1 333.8 334.6 5047.8 5088.9 5224.3 5316.2 5339.2 5152.6 5161.9 5166.7 5185.2 5208.1 4128.9 4131.7 4134.6 4149.6 4157.5 3973.7 4099.4 4148.5 4148.6 4161.4 4058.8 4061.2 4070.7 4079.2 4086.4 4047.4 4055.3 4055.4 4071.6 4077.6 3454.4 3551.4 3561.9 3575.6 3613.7 5004.7 5006.8 5020.9 5021.8 5035.4 4542.5 4568.2 4595.1 4601.9 4608.9 5167.9 5340.2 5351.5 5364.8 5414.0 3906.3 3911.3 3912.6 3919.8 3921.2 5595.9 5634.6 5644.2 5652.3 5656.3 3906.8 4006.8 4007.5 4010.3 4014.9 4026.5 4031.6 4044.0 4047.5 4047.5 4610.5 4614.9 4626.7 4627.7 4628.4 5233.1 5425.8 5426.9 5452.6 5475.2 1377.0 1397.6 1398.3 1400.4 1403.1 866.9 901.1 911.2 912.6 926.6 4632.7 4634.6 4642.6 4642.6 4650.8 4848.0 4919.8 4929.6 4970.8 4999.7 4501.7 4727.1 4728.6 4729.9 4735.3 2618.7 2633.5 2655.7 2658.6 2670.5 5079.0 5102.5 5128.6 5152.6 5169.4 4679.3 4980.8 5011.3 5093.8 5132.3 5050.4 5108.5 5113.3 5118.8 5131.9 4919.8 4932.6 4953.0 4962.4 4972.3 4894.7 4896.4 4913.3 5074.8 5546.7 5702.0 5732.9 5734.9 5763.2 5772.4 3857.0 3970.7 3991.7 3994.1 4025.3 5523.8 5555.7 5599.2 5610.9 5621.3 5481.4 5493.2 5504.4 5506.0 5507.7 5268.2 5429.8 5432.7 5437.3 5456.4 5383.2 5392.9 5404.7 5425.6 5447.9 5289.3 5451.0 5484.4 5486.1 5543.8 5319.9 5325.9 5338.2 5341.8 5390.2 06:08:20 INFO - PROCESS | 23711 | 06:08:20 INFO - PROCESS | 23711 | [#5] yui.html Cycles:180 Average:22380.09 Median:4699.23 stddev:33190.38 (706.3%) stddev-sans-first:33243.77 06:08:20 INFO - PROCESS | 23711 | Values: 753.6 810.1 814.7 820.3 825.9 15606.5 15709.5 16143.7 16655.5 16668.4 14410.2 14557.6 14623.4 14632.3 14640.6 658.6 789.9 804.0 804.4 804.9 787.8 813.9 815.5 821.6 821.8 858.7 860.4 865.9 866.0 866.3 683.6 835.3 836.5 836.7 836.7 600.4 610.1 618.0 619.8 620.8 15259.3 15305.7 15366.8 15397.6 15408.0 13933.3 14295.8 14691.4 14697.5 14848.2 13417.9 13447.4 13481.6 13856.4 13869.7 4563.3 4675.6 4718.9 4809.9 4867.4 82925.2 83004.6 83420.0 84633.2 84638.6 11588.9 11671.9 11754.2 11907.0 12357.3 22262.8 22462.2 22486.8 22492.4 22602.3 8801.0 8851.3 8884.9 9088.3 9209.8 4679.6 4838.2 4917.3 4929.8 5007.1 3543.3 3660.6 3672.5 3682.1 3685.4 583.8 592.9 600.7 600.9 603.3 567.9 570.4 591.5 658.2 712.4 8151.3 8494.7 9200.0 9491.3 9701.9 625.8 687.7 704.5 712.8 732.4 4355.3 4594.9 4665.0 4779.1 4781.7 124414.1 129724.0 130205.0 132490.3 133547.3 99181.5 108189.0 108435.8 110956.0 112802.4 95782.0 98204.0 98327.0 98410.0 98742.0 9706.7 9733.5 9826.2 9966.9 10175.7 51951.7 52538.7 52590.7 53407.7 53642.9 75328.0 76506.6 77774.2 79905.8 80703.0 12616.1 12951.8 12953.5 13005.3 13256.1 14875.3 15122.9 15198.2 15447.8 16316.8 14109.2 14141.2 14500.1 14898.3 15223.4 14633.9 14759.6 14766.6 15039.5 15176.6 14427.6 14457.6 14643.9 14887.3 15402.1 10291.2 10729.7 10997.1 11009.2 11021.4 10137.0 10157.3 10906.8 11778.2 12067.5 06:08:20 INFO - PROCESS | 23711 | -------- Summary: end -------- 06:08:20 INFO - PROCESS | 23711 | 06:08:21 INFO - TEST-INFO | 23711: exit 0 06:08:21 INFO - TEST-OK | dromaeo_css | took 1114842ms 06:08:21 INFO - TEST-START | kraken 06:08:21 INFO - operating with platform_type : linux_ 06:08:21 INFO - Initialising browser for kraken test... 06:08:21 INFO - TEST-INFO | started process 24020 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGY8I6f/profile http://localhost:33241/getInfo.html) 06:08:25 INFO - PROCESS | 24020 | __metrics Screen width/height:1600/1200 06:08:25 INFO - PROCESS | 24020 | colorDepth:24 06:08:25 INFO - PROCESS | 24020 | Browser inner width/height: 1024/697 06:08:25 INFO - PROCESS | 24020 | __metrics 06:08:26 INFO - PROCESS | 24020 | 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" 06:08:26 INFO - PROCESS | 24020 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:08:26 INFO - PROCESS | 24020 | console.error: PushService: 06:08:26 INFO - PROCESS | 24020 | stateChangeProcessEnqueue: Error transitioning state 06:08:26 INFO - PROCESS | 24020 | UnknownError 06:08:27 INFO - TEST-INFO | 24020: exit 0 06:08:27 INFO - Browser initialized. 06:08:27 INFO - Running cycle 1/1 for kraken test... 06:08:27 INFO - TEST-INFO | started process 24100 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGY8I6f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:39 INFO - PROCESS | 24100 | RSS: Main: 179122176 06:08:39 INFO - PROCESS | 24100 | 06:08:41 INFO - PROCESS | 24100 | Cycle 1(1): loaded http://localhost:33241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33241/tests/kraken/driver.html?testName=audio-beat-detection) 06:08:42 INFO - PROCESS | 24100 | RSS: Main: 233836544 06:08:42 INFO - PROCESS | 24100 | 06:08:45 INFO - PROCESS | 24100 | Cycle 1(1): loaded http://localhost:33241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33241/tests/kraken/driver.html?testName=audio-dft) 06:08:46 INFO - PROCESS | 24100 | RSS: Main: 223752192 06:08:46 INFO - PROCESS | 24100 | 06:08:49 INFO - PROCESS | 24100 | Cycle 1(1): loaded http://localhost:33241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33241/tests/kraken/driver.html?testName=audio-fft) 06:08:49 INFO - PROCESS | 24100 | RSS: Main: 300417024 06:08:49 INFO - PROCESS | 24100 | 06:08:51 INFO - PROCESS | 24100 | Cycle 1(1): loaded http://localhost:33241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33241/tests/kraken/driver.html?testName=audio-oscillator) 06:08:52 INFO - PROCESS | 24100 | RSS: Main: 210837504 06:08:52 INFO - PROCESS | 24100 | 06:08:54 INFO - PROCESS | 24100 | Cycle 1(1): loaded http://localhost:33241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:08:55 INFO - PROCESS | 24100 | RSS: Main: 213602304 06:08:55 INFO - PROCESS | 24100 | 06:08:58 INFO - PROCESS | 24100 | Cycle 1(1): loaded http://localhost:33241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33241/tests/kraken/driver.html?testName=imaging-darkroom) 06:08:58 INFO - PROCESS | 24100 | RSS: Main: 252248064 06:08:58 INFO - PROCESS | 24100 | 06:09:02 INFO - PROCESS | 24100 | Cycle 1(1): loaded http://localhost:33241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33241/tests/kraken/driver.html?testName=imaging-desaturate) 06:09:02 INFO - PROCESS | 24100 | RSS: Main: 251744256 06:09:02 INFO - PROCESS | 24100 | 06:09:05 INFO - PROCESS | 24100 | Cycle 1(1): loaded http://localhost:33241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33241/tests/kraken/driver.html?testName=json-parse-financial) 06:09:06 INFO - PROCESS | 24100 | RSS: Main: 251600896 06:09:06 INFO - PROCESS | 24100 | 06:09:07 INFO - PROCESS | 24100 | Cycle 1(1): loaded http://localhost:33241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:09:08 INFO - PROCESS | 24100 | RSS: Main: 213471232 06:09:08 INFO - PROCESS | 24100 | 06:09:09 INFO - PROCESS | 24100 | Cycle 1(1): loaded http://localhost:33241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33241/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:09:10 INFO - PROCESS | 24100 | RSS: Main: 222060544 06:09:10 INFO - PROCESS | 24100 | 06:09:12 INFO - PROCESS | 24100 | Cycle 1(1): loaded http://localhost:33241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:09:13 INFO - PROCESS | 24100 | RSS: Main: 222724096 06:09:13 INFO - PROCESS | 24100 | 06:09:15 INFO - PROCESS | 24100 | Cycle 1(1): loaded http://localhost:33241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:09:16 INFO - PROCESS | 24100 | RSS: Main: 217178112 06:09:16 INFO - PROCESS | 24100 | 06:09:19 INFO - PROCESS | 24100 | Cycle 1(1): loaded http://localhost:33241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:09:19 INFO - PROCESS | 24100 | RSS: Main: 220917760 06:09:19 INFO - PROCESS | 24100 | 06:09:21 INFO - PROCESS | 24100 | Cycle 1(1): loaded http://localhost:33241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33241/tests/kraken/driver.html?testName=ai-astar) 06:09:21 INFO - PROCESS | 24100 | RSS: Main: 272052224 06:09:21 INFO - PROCESS | 24100 | 06:09:21 INFO - PROCESS | 24100 | __start_tp_report 06:09:21 INFO - PROCESS | 24100 | _x_x_mozilla_page_load 06:09:21 INFO - PROCESS | 24100 | _x_x_mozilla_page_load_details 06:09:21 INFO - PROCESS | 24100 | |i|pagename|runs| 06:09:21 INFO - PROCESS | 24100 | |0;ai-astar;111;110;116;109;112;113;111;111;111;127 06:09:21 INFO - PROCESS | 24100 | |1;audio-beat-detection;148;115;145;178;119;149;155;120;180;120 06:09:21 INFO - PROCESS | 24100 | |2;audio-dft;160;160;160;160;161;161;161;160;161;160 06:09:21 INFO - PROCESS | 24100 | |3;audio-fft;74;74;75;167;76;76;75;75;155;77 06:09:21 INFO - PROCESS | 24100 | |4;audio-oscillator;82;82;144;83;82;82;150;83;83;138 06:09:21 INFO - PROCESS | 24100 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 06:09:21 INFO - PROCESS | 24100 | |6;imaging-darkroom;146;147;147;146;146;148;147;146;147;145 06:09:21 INFO - PROCESS | 24100 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 06:09:21 INFO - PROCESS | 24100 | |8;json-parse-financial;51;50;52;52;53;52;53;51;53;53 06:09:21 INFO - PROCESS | 24100 | |9;json-stringify-tinderbox;61;62;61;62;62;62;62;62;62;63 06:09:21 INFO - PROCESS | 24100 | |10;stanford-crypto-aes;79;79;78;89;85;79;78;79;88;79 06:09:21 INFO - PROCESS | 24100 | |11;stanford-crypto-ccm;123;128;127;127;132;129;132;126;218;127 06:09:21 INFO - PROCESS | 24100 | |12;stanford-crypto-pbkdf2;168;167;162;162;161;170;159;167;162;166 06:09:21 INFO - PROCESS | 24100 | |13;stanford-crypto-sha256-iterative;64;65;74;64;66;65;64;64;64;72 06:09:21 INFO - PROCESS | 24100 | __end_tp_report 06:09:21 INFO - PROCESS | 24100 | __start_cc_report 06:09:21 INFO - PROCESS | 24100 | _x_x_mozilla_cycle_collect,1653 06:09:21 INFO - PROCESS | 24100 | __end_cc_report 06:09:21 INFO - PROCESS | 24100 | __startTimestamp1472908161753__endTimestamp 06:09:21 INFO - PROCESS | 24100 | 06:09:21 INFO - PROCESS | 24100 | ------- Summary: start ------- 06:09:21 INFO - PROCESS | 24100 | Number of tests: 14 06:09:21 INFO - PROCESS | 24100 | 06:09:21 INFO - PROCESS | 24100 | [#0] ai-astar Cycles:10 Average:113.10 Median:111.50 stddev:5.24 (4.7%) stddev-sans-first:5.50 06:09:21 INFO - PROCESS | 24100 | Values: 111.0 110.0 116.0 109.0 112.0 113.0 111.0 111.0 111.0 127.0 06:09:21 INFO - PROCESS | 24100 | 06:09:21 INFO - PROCESS | 24100 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:148.50 stddev:24.09 (16.2%) stddev-sans-first:25.48 06:09:21 INFO - PROCESS | 24100 | Values: 148.0 115.0 145.0 178.0 119.0 149.0 155.0 120.0 180.0 120.0 06:09:21 INFO - PROCESS | 24100 | 06:09:21 INFO - PROCESS | 24100 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 06:09:21 INFO - PROCESS | 24100 | Values: 160.0 160.0 160.0 160.0 161.0 161.0 161.0 160.0 161.0 160.0 06:09:21 INFO - PROCESS | 24100 | 06:09:21 INFO - PROCESS | 24100 | [#3] audio-fft Cycles:10 Average:92.40 Median:75.00 stddev:36.28 (48.4%) stddev-sans-first:37.86 06:09:21 INFO - PROCESS | 24100 | Values: 74.0 74.0 75.0 167.0 76.0 76.0 75.0 75.0 155.0 77.0 06:09:21 INFO - PROCESS | 24100 | 06:09:21 INFO - PROCESS | 24100 | [#4] audio-oscillator Cycles:10 Average:100.90 Median:82.00 stddev:29.88 (36.4%) stddev-sans-first:30.90 06:09:21 INFO - PROCESS | 24100 | Values: 82.0 82.0 144.0 83.0 82.0 82.0 150.0 83.0 83.0 138.0 06:09:21 INFO - PROCESS | 24100 | 06:09:21 INFO - PROCESS | 24100 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 06:09:21 INFO - PROCESS | 24100 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 06:09:21 INFO - PROCESS | 24100 | 06:09:21 INFO - PROCESS | 24100 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 06:09:21 INFO - PROCESS | 24100 | Values: 146.0 147.0 147.0 146.0 146.0 148.0 147.0 146.0 147.0 145.0 06:09:21 INFO - PROCESS | 24100 | 06:09:21 INFO - PROCESS | 24100 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:09:21 INFO - PROCESS | 24100 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 06:09:21 INFO - PROCESS | 24100 | 06:09:21 INFO - PROCESS | 24100 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.50 stddev:1.05 (2.0%) stddev-sans-first:1.05 06:09:21 INFO - PROCESS | 24100 | Values: 51.0 50.0 52.0 52.0 53.0 52.0 53.0 51.0 53.0 53.0 06:09:21 INFO - PROCESS | 24100 | 06:09:21 INFO - PROCESS | 24100 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 06:09:21 INFO - PROCESS | 24100 | Values: 61.0 62.0 61.0 62.0 62.0 62.0 62.0 62.0 62.0 63.0 06:09:21 INFO - PROCESS | 24100 | 06:09:21 INFO - PROCESS | 24100 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:79.00 stddev:4.30 (5.4%) stddev-sans-first:4.48 06:09:21 INFO - PROCESS | 24100 | Values: 79.0 79.0 78.0 89.0 85.0 79.0 78.0 79.0 88.0 79.0 06:09:21 INFO - PROCESS | 24100 | 06:09:21 INFO - PROCESS | 24100 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:128.50 stddev:28.62 (22.3%) stddev-sans-first:29.91 06:09:21 INFO - PROCESS | 24100 | Values: 123.0 128.0 127.0 127.0 132.0 129.0 132.0 126.0 218.0 127.0 06:09:21 INFO - PROCESS | 24100 | 06:09:21 INFO - PROCESS | 24100 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:166.50 stddev:3.63 (2.2%) stddev-sans-first:3.61 06:09:21 INFO - PROCESS | 24100 | Values: 168.0 167.0 162.0 162.0 161.0 170.0 159.0 167.0 162.0 166.0 06:09:21 INFO - PROCESS | 24100 | 06:09:21 INFO - PROCESS | 24100 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:65.00 stddev:3.68 (5.7%) stddev-sans-first:3.81 06:09:21 INFO - PROCESS | 24100 | Values: 64.0 65.0 74.0 64.0 66.0 65.0 64.0 64.0 64.0 72.0 06:09:21 INFO - PROCESS | 24100 | -------- Summary: end -------- 06:09:21 INFO - PROCESS | 24100 | 06:09:22 INFO - TEST-INFO | 24100: exit 0 06:09:22 INFO - TEST-OK | kraken | took 61211ms 06:09:22 INFO - SUITE-END | took 1176s 06:09:23 INFO - Completed test suite (00:19:36) 06:09:23 INFO - javascript benchmark 06:09:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2947.6904924982878, 2955.4089182163566, 2969.406118776244, 2999.5050816615258, 3026.394721055788, 5025.974870125644, 5100.846974590759, 5155.510226528479, 5221.216817477381, 5238.738063096849, 5167.7932882684745, 5195.948040519594, 5240.973795131019, 5249.396319423267, 5269.86825329367, 4652.232381657022, 4704.764761761915, 4712.5523075307965, 4724.291356296549, 4890.046440944017, 4805.351277577534, 4834.782434790425, 4848.854534363974, 4852.975735121319, 4885.8778530536665, 4656.790444429992, 4672.15901137795, 4709.293605959134, 4738.24188129901, 4768.90462190756, 4707.270373092176, 4707.45864225615, 4726.1020406122725, 4738.928916066262, 4791.856244312677, 4726.385569875929, 4755.548222918817, 4758.191107511697, 4800.687955282895, 4813.940932994736, 5019.247112933052, 5150.3047088642925, 5215.739213039333, 5230.08473517133, 5252.0283747506455, 5530.668159910378, 5545.889082218373, 5577.498025177713, 5585.357683866326, 5640.097584386478, 5570.888582228374, 5603.691796951166, 5611.971940140274, 5617.494425501724, 5618.297712785902, 5074.441811400743, 5127.051495473312, 5149.407818100892, 5159.896802063938, 5204.609654275944, 5629.352624448241, 5633.0, 5636.689982051026, 5638.689872056994, 5698.202251684767, 5440.591955603346, 5446.101393270145, 5447.319085114361, 5450.264214331015, 5450.591205659592, 5332.600054995891, 5422.322209723785, 5461.617686761889, 5467.835964921059, 5499.1476321170285, 5469.671819690831, 5470.288862447936, 5471.288732464834, 5474.288342515448, 5521.420250873681, 5484.61607687458, 5489.6980666062955, 5493.368262649767, 5495.203195536705, 5558.749856256478, 4223.345381465878, 4225.302825033897, 4283.357496375568, 4284.357346398066, 4292.828286868553, 3816.961830381716, 3823.3882578787816, 3859.5754467008605, 3860.2279544091293, 3876.8061596920606, 5184.170532714823, 5192.636515443958, 5194.714290713971, 5195.116830138885, 5255.290535777697, 5313.415524292324, 5467.507924286833, 5505.504504594605, 5507.642003269774, 5547.55619550435, 5219.817306394258, 5224.817131400383, 5286.7092309922555, 5290.576753859682, 5306.973465132727, 4829.1307564638, 4842.297866809293, 4877.3903262092235, 4884.804607815719, 4942.406911170682, 5557.194206840067, 5772.7690892363835, 5773.566982476331, 5782.855428614318, 5783.566232532577, 5486.862828429162, 5519.227308176778, 5544.667319960815, 5548.445155484419, 5617.045102332695, 5698.0, 5698.715064246854, 5700.629459085146, 5705.686187259741, 5707.343655479673, 5316.441773613715, 5412.83761487156, 5429.918551221655, 5433.508130304299, 5434.402215756343, 5478.616496845182, 5529.944700552943, 5532.889342213214, 5549.72251387421, 5637.46444087811, 5385.192221166856, 5417.702026388586, 5435.076037073786, 5447.918281225706, 5448.618596698193, 5318.441563635763, 5399.969131653423, 5436.103042998019, 5442.074847275893, 5514.255575497256, 5341.5459685927135, 5388.110961691434, 5388.353397592314, 5405.5135037846785, 5471.671699698031, 5461.044317244387, 5494.587905907153, 5500.9174862377895, 5506.146547285177, 5507.284053073075, 5230.084735171406, 5241.659292146151, 5373.2746079278795, 5381.058314794817, 5437.592180586393], "value": 5116.356953968839, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.6923986403272, 587.8324677466923, 612.5926259037743, 614.4377894226783, 630.3727790848106, 43079.0, 44258.33612495815, 44521.554784452106, 44615.0, 48164.27753583699, 45676.314855277116, 45793.0, 45880.31179532301, 46120.0, 46162.76918615411, 9005.729828105152, 9147.771305717377, 9156.221721153677, 9156.679516216935, 9158.221551168159, 8961.551922403887, 9020.819583608323, 9046.592903319333, 9047.819043619123, 9048.185663290302, 9024.142706442877, 9071.410358326688, 9080.500572468512, 9080.954595227015, 9081.0, 8976.640934362651, 8997.190252877239, 9005.414648047856, 9005.729828105168, 9014.368994170378, 8992.775180620536, 9048.638054477813, 9059.909400905972, 9070.591823367964, 9074.274058075338, 42748.78625606852, 43130.56869431297, 43141.98006139571, 43146.78426607878, 43148.137037259075, 3444.7588668793196, 3570.357335679577, 3586.37238483267, 3588.4258518637153, 3671.229041901204, 32636.67363326384, 32881.177970550685, 32922.0, 32944.1763955903, 33076.0, 4398.912021759579, 4523.7285762854335, 4550.089982003613, 4606.723596584216, 4636.652251081183, 338215.0, 338581.0, 339922.0, 340692.0, 341059.29470352735, 57129.0, 57771.42228577661, 57791.711041445364, 57855.42144578585, 57860.13209801856, 61276.0, 61311.0, 61317.0, 61400.0, 61471.0, 15978.76031859523, 16390.26243819031, 16394.918025410036, 16395.754063689055, 16396.09821459831, 12404.25574465535, 12603.495860165674, 12629.747405051847, 12638.810417843555, 12642.747145057047, 15784.763228551581, 16977.575560611083, 17097.145142743062, 17099.91450042767, 17435.302587896596, 5763.164341170507, 5765.308163020464, 5797.275340582427, 5818.738156782955, 5899.646021238739, 893.584483215308, 1021.6883850425543, 1025.4565080507343, 1026.7741096958657, 1127.3067063755896, 31807.522887156712, 32027.0, 32180.35639287248, 32306.0, 32699.83650081782, 1051.2115913065202, 1076.7900259449332, 1079.266099052636, 1110.4725255503572, 1176.817593273044, 16028.0, 16675.166241687868, 16767.0, 16931.0, 16933.407330743365, 508392.0, 512986.0, 513876.0, 514012.0, 515272.0, 57933.420665793645, 58271.41728582745, 58296.70851645715, 58332.41667583355, 58348.416515834295, 1274.388293619068, 1329.9667508312175, 1334.1394800353912, 1342.3020029584561, 1354.844192917827, 29748.335962066125, 31963.0, 32030.839845800623, 32097.679023209468, 32532.72270941106, 51102.0, 51484.227736583234, 51688.74155629198, 51806.0, 51848.222276665125, 348074.0, 348078.1921807799, 348856.0, 348964.0, 350695.0, 27564.58653120245, 28262.15213543597, 28354.574681379385, 29978.85010574933, 41618.79190604028, 46982.530174697815, 47158.76420617875, 47426.28860567163, 47647.52352476431, 48958.26562601635, 39294.214115718096, 40039.1992160161, 40518.79740601278, 40561.391579125746, 42293.0, 39930.11561609159, 40624.0, 40878.38682419826, 41224.38163427491, 41552.376714348706, 39797.60202397939, 40059.0, 40373.0, 40650.0, 41285.79357103195, 33090.0, 35289.82355088208, 36296.637033629326, 36418.0, 36556.26887462183, 27574.310642234104, 27763.583546247228, 27789.722102778713, 28100.859495702392, 28103.71896281011], "value": 19888.78748003139, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.5350681388043, 379.7360834220218, 388.8464056697604, 395.8752992807266, 417.1177958617523, 16483.670326593478, 18933.538639976818, 18937.0, 19124.426267211988, 19314.61370772587, 17733.7339939901, 18233.726494102564, 18267.08664566773, 18710.25158993642, 18711.53221169468, 5291.788328466857, 5413.566914646819, 5416.91874621881, 5420.566354691615, 5493.478119578634, 5720.485156335929, 5843.298804143508, 5848.41515848416, 5851.414858514136, 5854.063349864023, 5353.357597088355, 5390.460953904618, 5817.272840894888, 5819.33077696064, 5819.53443724501, 5274.235235890813, 5306.283651707028, 5310.309659744247, 5314.627976041678, 5353.464653534635, 5072.264521644341, 5101.0, 5161.3806343238675, 5174.922376164361, 5265.921011184835, 14242.0, 14419.927900360432, 18206.726899096524, 22957.0, 23197.304080877602, 2281.9657705134437, 2299.908003679851, 2364.1725396111224, 2381.773731495505, 2386.3914701751114, 10372.585096596127, 10595.0, 10891.509882055327, 11016.834747478793, 12224.205426647239, 1909.7230901519201, 1980.7722111957166, 1985.8510611704035, 1987.691907754286, 2037.1851259496173, 79017.60491197507, 81857.59071204666, 82760.58619706862, 82877.58561207155, 83386.0, 10138.442385668712, 10388.37669739818, 10468.738281543023, 11085.279456835442, 12122.09084318662, 15487.5353739388, 15944.601384965468, 15964.521064368088, 15979.280932358071, 15989.12059836697, 7933.087694915159, 8054.637541310655, 8154.5514996674565, 8337.332053742866, 8399.328053755686, 7609.315161635479, 7652.655630496641, 7666.9616651917495, 7865.685372585147, 7937.761867143995, 4768.0, 4837.346958160673, 4851.34506841579, 4975.601951843843, 4984.626153038536, 1921.3275353626118, 1935.2742721479444, 1969.2713695932596, 2018.7476565429322, 2031.4616626593966, 926.8517037274004, 992.300428198133, 1028.7942411517577, 1031.185363562792, 1067.631667074858, 19051.61896762057, 19448.4165475036, 19758.70361944572, 19791.802081979284, 20145.093470793556, 911.8221946720458, 939.0515579264992, 958.496789185683, 967.7919247361851, 1022.4070039377292, 10067.69796906094, 10574.89425105739, 10739.248252622241, 10761.300515466626, 10802.567897284178, 447492.0, 451919.0, 452275.0, 473805.0, 475702.0, 92606.0, 92714.53642731743, 92852.0, 93669.5316523413, 94020.0, 999.0, 1037.725002874239, 1056.5034433816095, 1059.4067322299536, 1068.5512084924194, 16580.917095414447, 16674.249658765628, 17204.0, 17441.56396090057, 17847.821521785136, 38336.42495362516, 39852.2029559413, 43186.0, 44005.77997109994, 45135.54864451445, 56805.71597141988, 58079.12881306699, 58516.4148358528, 58746.41909018636, 59435.40564594472, 8290.253877151084, 8319.708810191614, 8402.201790829862, 8491.702790402307, 9107.908920910706, 10473.842892356468, 13161.670958226121, 13308.800367994294, 13311.00167487423, 13344.132631378929, 11449.942750286194, 11606.303621782383, 11615.36115513621, 11983.400829958642, 12252.754944900873, 11336.886631133582, 11389.202755807346, 11908.225965312227, 11913.285202887855, 12149.271043737404, 11789.351585662871, 11982.281063136239, 12089.15375923712, 12165.270083795001, 12220.572279970158, 7622.0, 8455.66177352899, 8711.869321960303, 8974.775630609287, 8975.50634715097, 10216.284860059724, 11690.123240756808, 11863.822042669195, 11866.0, 12185.0], "value": 9118.47402557553, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1256.9497220111195, 1471.440852476059, 1506.6685329227569, 1657.7679124922506, 1812.2479171143975, 8723.258523025543, 9190.81618367633, 9210.217131543826, 9221.7694557636, 9225.169734723873, 9082.182603565694, 9179.219766319855, 9190.770230744234, 9203.401778884385, 9206.677766278182, 2033.8372930165626, 2262.9207977720785, 2350.9294721158394, 2373.1338061607476, 2373.2168384433094, 2353.52929414117, 2375.2755409600063, 2381.249906279525, 2386.343755467243, 2386.916457923973, 2285.1773361589812, 2287.142321629389, 2336.836421450499, 2394.2338451695464, 2399.0763556030965, 2003.3088584438347, 2199.681046248285, 2261.31030035839, 2269.931902042941, 2305.319930620471, 2299.724033116037, 2331.0093210385517, 2340.6840076589615, 2341.110378056345, 2343.61330380487, 8919.598618062202, 8980.19178273952, 8995.910040899638, 8995.955020224923, 9004.369694121415, 5206.635535512516, 5336.866578335573, 5346.144616861284, 5354.116570765819, 5355.892882142374, 3070.1250143708935, 3173.5557022016937, 3349.8492567834264, 3370.4607262837826, 3370.69663730263, 1144.5765066925292, 1155.1163360029584, 1165.5745652836738, 1178.4166837415448, 1181.1377694283135, 12311.19977201488, 12410.503579856795, 12535.122541422104, 12539.310337931502, 12541.498340066386, 4458.509563947963, 4569.360289559464, 4700.412448443944, 4731.881702957454, 4769.236922092448, 10596.576136954589, 10694.625688101034, 10699.465026748632, 10703.090237329914, 10713.410762407986, 5281.445448227958, 5305.575553955674, 5307.071262529042, 5307.230451584499, 5312.362516498045, 4173.373993900878, 4731.52684731531, 4838.685485443435, 4856.781444834991, 4858.708477491362, 4090.6931980101017, 4119.941254850858, 4188.560201178832, 4208.179405015992, 4220.936685949713, 1227.5212667059855, 1304.1523010043359, 1309.2798960571647, 1315.8684131586956, 1329.5678904356123, 911.9544022798833, 930.4603330068544, 931.5668214280392, 939.3987847777428, 946.1201082992745, 5557.666540007613, 5750.856228594235, 5821.417858214145, 5939.990201665727, 6063.636181829104, 934.1499235695485, 959.2589450147959, 959.7456673981401, 962.1773383756787, 965.7199412170391, 3681.834317455721, 3816.923661526754, 3843.577206507282, 3855.7879316637855, 3914.8434062637743, 11092.0, 11533.250338727956, 11586.76826463483, 11594.536218551164, 11594.594189203506, 11146.21976461656, 11293.153013523854, 11446.19876608646, 11476.713082172846, 11527.365994870363, 8455.365847561457, 8595.527246001406, 8598.398112132216, 8600.827983440297, 8604.741857744402, 5605.635633683797, 5744.511716504144, 5746.454086861741, 5836.503897168788, 5976.671283079472, 10404.271700981162, 10432.947835260775, 10489.790204196026, 10530.631427899987, 10576.576936922436, 10096.091351778376, 10464.686059417925, 10469.895301046892, 10484.842727359248, 10568.154547636324, 7691.30778229962, 7916.456291023425, 7921.2870841622225, 8360.331173505983, 8545.786355341166, 8038.557879316693, 8503.0, 8682.78293042679, 8765.07966663491, 8772.210501054935, 7689.653965571674, 7732.690692372467, 7966.960165199137, 8066.435349525712, 8149.225823546753, 7555.924440755742, 7651.387888968758, 7669.501482403626, 7713.730019449293, 7893.57915575202, 7309.086364204474, 7433.442491813244, 7448.329650331496, 7454.142773581108, 7457.366123879531, 5186.0, 5301.575873929999, 5373.704446255493, 5436.7281635918835, 5522.0336441121835, 5192.532672059533, 5318.388385335581, 5340.572754179579, 5376.516113549643, 5387.973060134675], "value": 4702.457126520497, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.6489978573675, 325.9006003169034, 326.0641957581741, 333.77970539443965, 334.63859032245176, 5047.77285022174, 5088.949110508894, 5224.268602395668, 5316.20256961456, 5339.2113641929955, 5152.604039121808, 5161.9483805162035, 5166.741662916858, 5185.248139019849, 5208.140656791635, 4128.876133715993, 4131.73143745657, 4134.627883490492, 4149.564295748948, 4157.542670306279, 3973.6622387096986, 4099.405586190001, 4148.522919864209, 4148.605882441163, 4161.417401563784, 4058.7564746115327, 4061.1877624475073, 4070.694697897655, 4079.2045551117544, 4086.4483294755273, 4047.372657238118, 4055.3105971984833, 4055.4119652650347, 4071.6335529802163, 4077.571854955246, 3454.3954807908517, 3551.3607550640872, 3561.928761424783, 3575.6424357564297, 3613.7109031277696, 5004.699718016931, 5006.774695138727, 5020.899582008339, 5021.799128034874, 5035.370578677665, 4542.545745425464, 4568.223402021665, 4595.149897269016, 4601.930971035437, 4608.861734147981, 5167.896642067175, 5340.198970154469, 5351.518363347279, 5364.785408583691, 5413.998410294108, 3906.335922893115, 3911.2959667259884, 3912.6478616924614, 3919.7844118573466, 3921.156951255494, 5595.916061259084, 5634.605577609569, 5644.181593668895, 5652.34997975234, 5656.2929633795775, 3906.8046597670004, 4006.8397264109694, 4007.4971885542923, 4010.27814993304, 4014.9360419488858, 4026.4966879140106, 4031.576684448091, 4044.0, 4047.461964453548, 4047.494063242095, 4610.469795973506, 4614.930776038362, 4626.653001024869, 4627.722336659811, 4628.431220672559, 5233.110371236899, 5425.755840987165, 5426.9185962210595, 5452.645578037414, 5475.233467314579, 1376.9931150344185, 1397.6156556946717, 1398.3148257354026, 1400.43982407038, 1403.1440821099122, 866.9033672404413, 901.085398320705, 911.2072496927715, 912.5665308978315, 926.5598840550684, 4632.726000349863, 4634.58645113237, 4642.628589712815, 4642.632257548607, 4650.813967441264, 4848.0, 4919.754012299442, 4929.630277729185, 4970.826021089245, 4999.675021123688, 4501.6848820582245, 4727.101850648366, 4728.574428301401, 4729.929051064237, 4735.337052812609, 2618.6988496323165, 2633.5391306521283, 2655.7078721340636, 2658.5909467981614, 2670.492606404777, 5078.984203159383, 5102.540771330598, 5128.615353848476, 5152.562032227228, 5169.405518365361, 4679.321498382716, 4980.800767969313, 5011.34852469184, 5093.796248150106, 5132.307138536325, 5050.368703912011, 5108.540231379194, 5113.335266415416, 5118.769655365592, 5131.87170320745, 4919.778609962632, 4932.630052745986, 4952.975235123801, 4962.429320628174, 4972.254161875603, 4894.675029361025, 4896.4124305083615, 4913.263010548446, 5074.847754567369, 5546.696526316393, 5702.0, 5732.856678582902, 5734.90675903284, 5763.242211125479, 5772.422757724194, 3856.9614303857725, 3970.7220494565104, 3991.7426010806503, 3994.141259629194, 4025.335819589735, 5523.751431185526, 5555.694436805853, 5599.188117722989, 5610.9158362623775, 5621.269234999424, 5481.369642491005, 5493.176023596492, 5504.366997795145, 5506.0, 5507.669539827623, 5268.2361057647195, 5429.782808687608, 5432.696152923349, 5437.293151890229, 5456.417638884837, 5383.219433182245, 5392.946070539245, 5404.702741349263, 5425.647332923348, 5447.945520544744, 5289.285946397187, 5451.0, 5484.396716361117, 5486.149646804752, 5543.805966791143, 5319.867003324948, 5325.893482130258, 5338.225957236102, 5341.786328546815, 5390.218418329398], "value": 4038.9134012842565, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.5554023126355, 810.0926961802782, 814.6822739131738, 820.2822530285999, 825.9421840471169, 15606.453774117908, 15709.528714138594, 16143.677126457464, 16655.500334989956, 16668.416605418814, 14410.2074385909, 14557.563273101798, 14623.415063397479, 14632.268386580681, 14640.560783176496, 658.6081281637418, 789.9328557072641, 804.047204063184, 804.3766081287021, 804.90341159061, 787.8069872881152, 813.8819871118684, 815.4862436664893, 821.6425854753171, 821.8150916043902, 858.7295002074358, 860.3590325207729, 865.8917635295588, 866.0343716755804, 866.3199388480044, 683.5556888022775, 835.2941764209233, 836.506461187902, 836.6862426590029, 836.7113345895626, 600.4385899184233, 610.0513701194641, 617.9814605561841, 619.8140557832677, 620.7672122953892, 15259.313330900137, 15305.693886122326, 15366.769498457532, 15397.615059623487, 15408.0, 13933.30333483332, 14295.78556321656, 14691.412343506247, 14697.485588004369, 14848.183349915751, 13417.865821341758, 13447.394867230998, 13481.59555213345, 13856.376463059187, 13869.653258668513, 4563.292689633112, 4675.579197872174, 4718.882027949295, 4809.927851082237, 4867.36724225852, 82925.17074829235, 83004.58497707533, 83420.0, 84633.15366846314, 84638.57680711619, 11588.88411115895, 11671.877326187252, 11754.177207595387, 11907.024629761581, 12357.25856448598, 22262.77737222607, 22462.213822516132, 22486.775132248797, 22492.437689057577, 22602.321930342117, 8801.0, 8851.291896648252, 8884.911150888409, 9088.318376121817, 9209.815803684023, 4679.578837904605, 4838.153323168502, 4917.286993385939, 4929.802807887644, 5007.147355478423, 3543.344481270973, 3660.5790334111916, 3672.4674922136674, 3682.0978860179425, 3685.4287585424304, 583.8015074874563, 592.9021711417568, 600.7266693654377, 600.945914867664, 603.2640178981635, 567.9260310974174, 570.4381184533231, 591.4647244243966, 658.1772784019975, 712.3837880233664, 8151.30713889326, 8494.74515764528, 9199.95400023009, 9491.335606507479, 9701.90298097024, 625.8497960489541, 687.6767919078026, 704.5490885833071, 712.8431745016088, 732.3884556395469, 4355.324924636687, 4594.862154135381, 4665.011415239989, 4779.139754844162, 4781.737004464788, 124414.14060625566, 129724.0, 130205.0, 132490.33754831165, 133547.33226334, 99181.50409248052, 108189.0, 108435.83128337548, 110956.0, 112802.43598782118, 95782.0, 98204.0, 98327.0, 98410.0, 98742.0, 9706.725138913283, 9733.464659443798, 9826.219908263276, 9966.860065881629, 10175.694729158136, 51951.740241298554, 52538.73730631475, 52590.73704631453, 53407.73296133494, 53642.85428582813, 75328.0, 76506.61746691231, 77774.2222577767, 79905.8108317551, 80703.0, 12616.116871818884, 12951.805722913976, 12953.481860725842, 13005.349732513525, 13256.07207495466, 14875.256237187881, 15122.924385378443, 15198.240087995777, 15447.768283475982, 16316.755248671518, 14109.235036074635, 14141.222232777296, 14500.129992200502, 14898.25508724581, 15223.391064357302, 14633.926830365781, 14759.557213283619, 14766.63083422923, 15039.548813535173, 15176.620584485476, 14427.639309017359, 14457.638559036108, 14643.85356146425, 14887.330070146652, 15402.075875447508, 10291.228157888338, 10729.731756706145, 10997.12023038139, 11009.229353945148, 11021.393823339473, 10137.0, 10157.288989770645, 10906.836397454203, 11778.234414763014, 12067.456964436797], "value": 7779.640284787642, "unit": "score"}], "name": "dromaeo_css", "value": 7180.9388767030505, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 116.0, 109.0, 112.0, 113.0, 111.0, 111.0, 111.0, 127.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 115.0, 145.0, 178.0, 119.0, 149.0, 155.0, 120.0, 180.0, 120.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 161.0, 161.0, 161.0, 160.0, 161.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 167.0, 76.0, 76.0, 75.0, 75.0, 155.0, 77.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 144.0, 83.0, 82.0, 82.0, 150.0, 83.0, 83.0, 138.0], "value": 100.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 148.0, 147.0, 146.0, 147.0, 145.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 52.0, 52.0, 53.0, 52.0, 53.0, 51.0, 53.0, 53.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 89.0, 85.0, 79.0, 78.0, 79.0, 88.0, 79.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 128.0, 127.0, 127.0, 132.0, 129.0, 132.0, 126.0, 218.0, 127.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 162.0, 162.0, 161.0, 170.0, 159.0, 167.0, 162.0, 166.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 74.0, 64.0, 66.0, 65.0, 64.0, 64.0, 64.0, 72.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1530.8000000000002, "alertThreshold": 2.0}]} 06:09:23 INFO - Return code: 0 06:09:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:09:23 INFO - # TBPL SUCCESS # 06:09:23 INFO - Running post-action listener: _resource_record_post_action 06:09:23 INFO - [mozharness: 2016-09-03 13:09:23.572908Z] Finished run-tests step (success) 06:09:23 INFO - Running post-run listener: _resource_record_post_run 06:09:23 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 16384; Write bytes: 423825408; Read time: 220; Write time: 280380 06:09:23 INFO - TinderboxPrint: CPU usage
13.1% 06:09:23 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 220 06:09:23 INFO - TinderboxPrint: I/O write bytes / time
423,825,408 / 280,380 06:09:23 INFO - TinderboxPrint: CPU idle
8,277.6 (86.9%) 06:09:23 INFO - TinderboxPrint: CPU user
1,199.5 (12.6%) 06:09:23 INFO - TinderboxPrint: Swap in / out
0 / 0 06:09:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 134389760; Read time: 104; Write time: 88956 06:09:23 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288821248; Read time: 100; Write time: 191424 06:09:24 INFO - Running post-run listener: _upload_blobber_files 06:09:24 INFO - Blob upload gear active. 06:09:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:09:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:09:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:09:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:09:24 INFO - (blobuploader) - INFO - Open directory for files ... 06:09:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:09:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:09:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:25 INFO - (blobuploader) - INFO - Done attempting. 06:09:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:09:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:09:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:29 INFO - (blobuploader) - INFO - Done attempting. 06:09:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:09:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:09:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:30 INFO - (blobuploader) - INFO - Done attempting. 06:09:30 INFO - (blobuploader) - INFO - Iteration through files over. 06:09:30 INFO - Return code: 0 06:09:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:09:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:09:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5a11ff361c29273d8deac0d3a094bfb230db206685d946633f2e73d2137f186a0c4c434f3dca81dbcf287fe4cb25ba36ae82f8838d147787f4c380b669bb1e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/521b7be3370b3895ce7306c2da979e37106af53a366a479f9b991f9283f082ee669c026453555461d5f566873b0db6a237890f83e5295888f565f9a3f6239ba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4d25bd2520facec70bb1bda7184fe2c418af80a0ff0a88de30d3043a23886f51ab68b0e07feaa6f71a4053a05ff2aa6fd77e5e79af5ff596ad9b5ad0ebb17fe"} 06:09:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:09:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:09:30 INFO - Contents: 06:09:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5a11ff361c29273d8deac0d3a094bfb230db206685d946633f2e73d2137f186a0c4c434f3dca81dbcf287fe4cb25ba36ae82f8838d147787f4c380b669bb1e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/521b7be3370b3895ce7306c2da979e37106af53a366a479f9b991f9283f082ee669c026453555461d5f566873b0db6a237890f83e5295888f565f9a3f6239ba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4d25bd2520facec70bb1bda7184fe2c418af80a0ff0a88de30d3043a23886f51ab68b0e07feaa6f71a4053a05ff2aa6fd77e5e79af5ff596ad9b5ad0ebb17fe"} 06:09:30 INFO - Running post-run listener: copy_logs_to_upload_dir 06:09:30 INFO - Copying logs to upload dir... 06:09:30 INFO - mkdir: /builds/slave/test/build/upload/logs 06:09:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.532670 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-09-03 06:09:30.790098) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-03 06:09:30.793468) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452 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/sha512/a5a11ff361c29273d8deac0d3a094bfb230db206685d946633f2e73d2137f186a0c4c434f3dca81dbcf287fe4cb25ba36ae82f8838d147787f4c380b669bb1e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/521b7be3370b3895ce7306c2da979e37106af53a366a479f9b991f9283f082ee669c026453555461d5f566873b0db6a237890f83e5295888f565f9a3f6239ba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4d25bd2520facec70bb1bda7184fe2c418af80a0ff0a88de30d3043a23886f51ab68b0e07feaa6f71a4053a05ff2aa6fd77e5e79af5ff596ad9b5ad0ebb17fe"} build_url:https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011119 build_url: 'https://queue.taskcluster.net/v1/task/Z0qeCXh9TIeoJsgMddaCoQ/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/sha512/a5a11ff361c29273d8deac0d3a094bfb230db206685d946633f2e73d2137f186a0c4c434f3dca81dbcf287fe4cb25ba36ae82f8838d147787f4c380b669bb1e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/521b7be3370b3895ce7306c2da979e37106af53a366a479f9b991f9283f082ee669c026453555461d5f566873b0db6a237890f83e5295888f565f9a3f6239ba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4d25bd2520facec70bb1bda7184fe2c418af80a0ff0a88de30d3043a23886f51ab68b0e07feaa6f71a4053a05ff2aa6fd77e5e79af5ff596ad9b5ad0ebb17fe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-03 06:09:30.823604) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 06:09:30.823951) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1472906145.239996-152250452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 06:09:30.908900) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-03 06:09:30.909659) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-03 06:09:30.910405) ========= ========= Total master_lag: 0.18 =========