builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-050 starttime: 1472660352.67 results: success (0) buildid: 20160831075920 builduid: 942b35445e7c4fe4a59801253ce5bf88 revision: b3ec8a3373e8faca26c39e9ff577a2d4f8b6927a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 09:19:12.672432) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 09:19:12.672920) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 09:19:12.673213) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 09:19:12.688247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 09:19:12.688656) ========= 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=6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-31 09:19:14-- 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% 46.5M=0s 2016-08-31 09:19:14 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104731 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 09:19:12.810162) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 09:19:12.810964) ========= 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=6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018518 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 09:19:12.863757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 09:19:12.864475) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b3ec8a3373e8faca26c39e9ff577a2d4f8b6927a --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 b3ec8a3373e8faca26c39e9ff577a2d4f8b6927a --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=6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-31 09:19:14,388 truncating revision to first 12 chars 2016-08-31 09:19:14,389 Setting DEBUG logging. 2016-08-31 09:19:14,389 attempt 1/10 2016-08-31 09:19:14,389 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b3ec8a3373e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-31 09:19:14,645 unpacking tar archive at: mozilla-central-b3ec8a3373e8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.543762 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 09:19:13.426986) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 09:19:13.427772) ========= script_repo_revision: b3ec8a3373e8faca26c39e9ff577a2d4f8b6927a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 09:19:13.428764) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 09:19:13.429290) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 09:19:13.440761) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-31 09:19:13.441066) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:19:15 INFO - MultiFileLogger online at 20160831 09:19:15 in /builds/slave/test 09:19:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:19:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:19:15 INFO - {'append_to_log': False, 09:19:15 INFO - 'base_work_dir': '/builds/slave/test', 09:19:15 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:19:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:19:15 INFO - 'branch': 'Firefox-Non-PGO', 09:19:15 INFO - 'buildbot_json_path': 'buildprops.json', 09:19:15 INFO - 'config_files': ('talos/linux_config.py',), 09:19:15 INFO - 'default_actions': ('clobber', 09:19:15 INFO - 'read-buildbot-config', 09:19:15 INFO - 'download-and-extract', 09:19:15 INFO - 'populate-webroot', 09:19:15 INFO - 'create-virtualenv', 09:19:15 INFO - 'install', 09:19:15 INFO - 'run-tests'), 09:19:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:19:15 INFO - 'download_minidump_stackwalk': True, 09:19:15 INFO - 'download_symbols': 'ondemand', 09:19:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:19:15 INFO - 'tooltool.py': '/tools/tooltool.py', 09:19:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:19:15 INFO - '/tools/misc-python/virtualenv.py')}, 09:19:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:19:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:19:15 INFO - 'installer_path': 'installer.exe', 09:19:15 INFO - 'log_level': 'info', 09:19:15 INFO - 'log_name': 'talos', 09:19:15 INFO - 'log_to_console': True, 09:19:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:19:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:19:15 INFO - 'opt_config_files': (), 09:19:15 INFO - 'pip_index': False, 09:19:15 INFO - 'sps_profile': False, 09:19:15 INFO - 'sps_profile_interval': 0, 09:19:15 INFO - 'suite': 'dromaeojs-e10s', 09:19:15 INFO - 'system_bits': '32', 09:19:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:19:15 INFO - 'title': 'talos-linux64-ix-050', 09:19:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:19:15 INFO - 'use_talos_json': True, 09:19:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:19:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:19:15 INFO - 'work_dir': 'build'} 09:19:15 INFO - [mozharness: 2016-08-31 16:19:15.053795Z] Running clobber step. 09:19:15 INFO - Running pre-action listener: _resource_record_pre_action 09:19:15 INFO - Running main action method: clobber 09:19:15 INFO - rmtree: /builds/slave/test/build 09:19:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:19:16 INFO - Running post-action listener: _resource_record_post_action 09:19:16 INFO - [mozharness: 2016-08-31 16:19:16.078658Z] Finished clobber step (success) 09:19:16 INFO - [mozharness: 2016-08-31 16:19:16.078760Z] Running read-buildbot-config step. 09:19:16 INFO - Running pre-action listener: _resource_record_pre_action 09:19:16 INFO - Running main action method: read_buildbot_config 09:19:16 INFO - Using buildbot properties: 09:19:16 INFO - { 09:19:16 INFO - "project": "", 09:19:16 INFO - "product": "firefox", 09:19:16 INFO - "script_repo_revision": "production", 09:19:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:19:16 INFO - "repository": "", 09:19:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:19:16 INFO - "buildid": "20160831075920", 09:19:16 INFO - "pgo_build": "False", 09:19:16 INFO - "basedir": "/builds/slave/test", 09:19:16 INFO - "buildnumber": 450, 09:19:16 INFO - "slavename": "talos-linux64-ix-050", 09:19:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:19:16 INFO - "platform": "ubuntu64_hw", 09:19:16 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:19:16 INFO - "branch": "mozilla-central", 09:19:16 INFO - "repo_path": "mozilla-central", 09:19:16 INFO - "revision": "b3ec8a3373e8faca26c39e9ff577a2d4f8b6927a", 09:19:16 INFO - "stage_platform": "linux64", 09:19:16 INFO - "builduid": "942b35445e7c4fe4a59801253ce5bf88", 09:19:16 INFO - "slavebuilddir": "test" 09:19:16 INFO - } 09:19:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 09:19:16 INFO - Running post-action listener: _resource_record_post_action 09:19:16 INFO - [mozharness: 2016-08-31 16:19:16.081264Z] Finished read-buildbot-config step (success) 09:19:16 INFO - [mozharness: 2016-08-31 16:19:16.081354Z] Running download-and-extract step. 09:19:16 INFO - Running pre-action listener: _resource_record_pre_action 09:19:16 INFO - Running main action method: download_and_extract 09:19:16 INFO - mkdir: /builds/slave/test/build/tests 09:19:16 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')]} 09:19:16 INFO - trying https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:19:16 INFO - Downloading https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/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 09:19:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/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 09:19:16 INFO - Downloaded 1361 bytes. 09:19:16 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:19:16 INFO - Using the following test package requirements: 09:19:16 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:19:16 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:19:16 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:19:16 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:16 INFO - u'jsshell-linux-x86_64.zip'], 09:19:16 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:19:16 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:19:16 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:19:16 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:19:16 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:19:16 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:19:16 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:19:16 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')]} 09:19:16 INFO - trying https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:19:16 INFO - Downloading https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/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 09:19:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/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 09:19:17 INFO - Downloaded 20332109 bytes. 09:19:17 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 09:19:21 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 09:19: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')]} 09:19:21 INFO - trying https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:19:21 INFO - Downloading https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/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 09:19:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/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 09:19:22 INFO - Downloaded 20332109 bytes. 09:19:22 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 09:19:27 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')]} 09:19:27 INFO - trying https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:19:27 INFO - Downloading https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/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 09:19:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/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 09:19:27 INFO - Downloaded 14413998 bytes. 09:19:27 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 09:19: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')]} 09:19:28 INFO - trying https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:19:28 INFO - Downloading https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/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 09:19:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/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 09:19:29 INFO - Downloaded 55863105 bytes. 09:19:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:19:29 INFO - mkdir: /builds/slave/test/properties 09:19:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:19:29 INFO - Writing to file /builds/slave/test/properties/build_url 09:19:29 INFO - Contents: 09:19:29 INFO - build_url:https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:19:30 INFO - Running post-action listener: _resource_record_post_action 09:19:30 INFO - Running post-action listener: set_extra_try_arguments 09:19:30 INFO - [mozharness: 2016-08-31 16:19:30.060897Z] Finished download-and-extract step (success) 09:19:30 INFO - [mozharness: 2016-08-31 16:19:30.061126Z] Running populate-webroot step. 09:19:30 INFO - Running pre-action listener: _resource_record_pre_action 09:19:30 INFO - Running main action method: populate_webroot 09:19:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:19:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:19:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:19:30 INFO - '--tppagecycles', 09:19:30 INFO - '7'], 09:19:30 INFO - 'tests': ['tsvgm']}}, 09:19:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:19:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:19:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:19:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:19:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:19:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:19:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:30 INFO - 'talos_options': ['--disable-e10s'], 09:19:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:30 INFO - 'talos_options': ['--disable-e10s'], 09:19:30 INFO - 'tests': ['damp', 'tps']}, 09:19:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:30 INFO - 'tests': ['damp', 'tps']}, 09:19:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:19:30 INFO - 'tests': ['dromaeo_dom']}, 09:19:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:19:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:19:30 INFO - 'tests': ['basic_compositor_video']}, 09:19:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:19:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:19:30 INFO - 'tests': ['a11yr', 09:19:30 INFO - 'ts_paint', 09:19:30 INFO - 'tpaint', 09:19:30 INFO - 'sessionrestore', 09:19:30 INFO - 'sessionrestore_no_auto_restore', 09:19:30 INFO - 'tabpaint']}, 09:19:30 INFO - 'other-e10s': {'tests': ['a11yr', 09:19:30 INFO - 'ts_paint', 09:19:30 INFO - 'tpaint', 09:19:30 INFO - 'sessionrestore', 09:19:30 INFO - 'sessionrestore_no_auto_restore', 09:19:30 INFO - 'tabpaint']}, 09:19:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:19:30 INFO - 'ts_paint', 09:19:30 INFO - 'tpaint', 09:19:30 INFO - 'sessionrestore', 09:19:30 INFO - 'sessionrestore_no_auto_restore', 09:19:30 INFO - 'tabpaint']}, 09:19:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:19:30 INFO - 'ts_paint', 09:19:30 INFO - 'tpaint', 09:19:30 INFO - 'sessionrestore', 09:19:30 INFO - 'sessionrestore_no_auto_restore', 09:19:30 INFO - 'tabpaint']}, 09:19:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:19:30 INFO - 'tests': ['a11yr', 09:19:30 INFO - 'ts_paint', 09:19:30 INFO - 'tpaint', 09:19:30 INFO - 'sessionrestore', 09:19:30 INFO - 'sessionrestore_no_auto_restore', 09:19:30 INFO - 'tabpaint']}, 09:19:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:19:30 INFO - 'tests': ['a11yr', 09:19:30 INFO - 'ts_paint', 09:19:30 INFO - 'tpaint', 09:19:30 INFO - 'sessionrestore', 09:19:30 INFO - 'sessionrestore_no_auto_restore', 09:19:30 INFO - 'tabpaint']}, 09:19:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:19:30 INFO - 'tests': ['tsvgx', 09:19:30 INFO - 'tsvgr_opacity', 09:19:30 INFO - 'tart', 09:19:30 INFO - 'tscrollx', 09:19:30 INFO - 'cart']}, 09:19:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:19:30 INFO - 'tsvgr_opacity', 09:19:30 INFO - 'tart', 09:19:30 INFO - 'tscrollx', 09:19:30 INFO - 'cart']}, 09:19:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:30 INFO - 'talos_options': ['--disable-e10s'], 09:19:30 INFO - 'tests': ['tp5o']}, 09:19:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:30 INFO - 'tests': ['tp5o']}, 09:19:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:30 INFO - 'talos_options': ['--disable-e10s', 09:19:30 INFO - '--xperf_path', 09:19:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:30 INFO - 'tests': ['tp5n']}, 09:19:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:30 INFO - 'talos_options': ['--xperf_path', 09:19:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:30 INFO - 'tests': ['tp5n']}}, 09:19:30 INFO - 'talos.zip': {'path': '', 09:19:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:19:30 INFO - Running post-action listener: _resource_record_post_action 09:19:30 INFO - [mozharness: 2016-08-31 16:19:30.076368Z] Finished populate-webroot step (success) 09:19:30 INFO - [mozharness: 2016-08-31 16:19:30.076458Z] Running create-virtualenv step. 09:19:30 INFO - Running pre-action listener: _resource_record_pre_action 09:19:30 INFO - Running main action method: create_virtualenv 09:19:30 INFO - Creating virtualenv /builds/slave/test/build/venv 09:19:30 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 09:19:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:19:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:19:30 INFO - Using real prefix '/usr' 09:19:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:19:30 INFO - Installing distribute.............................................................................................................................................................................................done. 09:19:32 INFO - Installing pip.................done. 09:19:32 INFO - Return code: 0 09:19:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:19:32 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')]} 09:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:32 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')]} 09:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:32 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 0x7fe8bb760f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17eb230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5090>, '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 0x17e89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e8e40>, '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': '6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843', '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 09:19:32 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 09:19:32 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 09:19:32 INFO - Using env: {'DISPLAY': ':0', 09:19:32 INFO - 'HOME': '/home/cltbld', 09:19:32 INFO - 'LANG': 'en_US.UTF-8', 09:19:32 INFO - 'LANGUAGE': 'en_US:en', 09:19:32 INFO - 'LOGNAME': 'cltbld', 09:19:32 INFO - 'MAIL': '/var/mail/cltbld', 09:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:32 INFO - 'MOZ_NO_REMOTE': '1', 09:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:32 INFO - 'NO_EM_RESTART': '1', 09:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:32 INFO - 'PWD': '/builds/slave/test', 09:19:32 INFO - 'SHELL': '/bin/bash', 09:19:32 INFO - 'SHLVL': '1', 09:19:32 INFO - 'TERM': 'linux', 09:19:32 INFO - 'TMOUT': '86400', 09:19:32 INFO - 'USER': 'cltbld', 09:19:32 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843', 09:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:32 INFO - '_': '/tools/buildbot/bin/python'} 09:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:32 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 09:19:32 INFO - Cleaning up... 09:19:32 INFO - Return code: 0 09:19:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:19:32 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')]} 09:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:32 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')]} 09:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:32 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 0x7fe8bb760f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17eb230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5090>, '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 0x17e89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e8e40>, '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': '6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843', '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 09:19:32 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 09:19:32 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 09:19:32 INFO - Using env: {'DISPLAY': ':0', 09:19:32 INFO - 'HOME': '/home/cltbld', 09:19:32 INFO - 'LANG': 'en_US.UTF-8', 09:19:32 INFO - 'LANGUAGE': 'en_US:en', 09:19:32 INFO - 'LOGNAME': 'cltbld', 09:19:32 INFO - 'MAIL': '/var/mail/cltbld', 09:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:32 INFO - 'MOZ_NO_REMOTE': '1', 09:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:32 INFO - 'NO_EM_RESTART': '1', 09:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:32 INFO - 'PWD': '/builds/slave/test', 09:19:32 INFO - 'SHELL': '/bin/bash', 09:19:32 INFO - 'SHLVL': '1', 09:19:32 INFO - 'TERM': 'linux', 09:19:32 INFO - 'TMOUT': '86400', 09:19:32 INFO - 'USER': 'cltbld', 09:19:32 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843', 09:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:32 INFO - '_': '/tools/buildbot/bin/python'} 09:19:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:33 INFO - Downloading/unpacking psutil>=3.1.1 09:19:33 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 09:19:33 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 09:19:33 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 09:19:33 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 09:19:33 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 09:19:33 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 09:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:19:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:35 INFO - Installing collected packages: psutil 09:19:35 INFO - Running setup.py install for psutil 09:19:35 INFO - building 'psutil._psutil_linux' extension 09:19:35 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 09:19:35 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 09:19:35 INFO - building 'psutil._psutil_posix' extension 09:19:35 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 09:19:35 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 09:19:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:35 INFO - Successfully installed psutil 09:19:35 INFO - Cleaning up... 09:19:35 INFO - Return code: 0 09:19:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:19:35 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')]} 09:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:35 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')]} 09:19:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:35 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 0x7fe8bb760f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17eb230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5090>, '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 0x17e89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e8e40>, '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': '6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843', '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 09:19:35 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 09:19:35 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 09:19:35 INFO - Using env: {'DISPLAY': ':0', 09:19:35 INFO - 'HOME': '/home/cltbld', 09:19:35 INFO - 'LANG': 'en_US.UTF-8', 09:19:35 INFO - 'LANGUAGE': 'en_US:en', 09:19:35 INFO - 'LOGNAME': 'cltbld', 09:19:35 INFO - 'MAIL': '/var/mail/cltbld', 09:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:35 INFO - 'MOZ_NO_REMOTE': '1', 09:19:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:35 INFO - 'NO_EM_RESTART': '1', 09:19:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:35 INFO - 'PWD': '/builds/slave/test', 09:19:35 INFO - 'SHELL': '/bin/bash', 09:19:35 INFO - 'SHLVL': '1', 09:19:35 INFO - 'TERM': 'linux', 09:19:35 INFO - 'TMOUT': '86400', 09:19:35 INFO - 'USER': 'cltbld', 09:19:35 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843', 09:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:35 INFO - '_': '/tools/buildbot/bin/python'} 09:19:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:19:35 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 09:19:35 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 09:19:35 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 09:19:35 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 09:19:35 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 09:19:35 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 09:19:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:19:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:19:37 INFO - Installing collected packages: mozsystemmonitor 09:19:37 INFO - Running setup.py install for mozsystemmonitor 09:19:37 INFO - Successfully installed mozsystemmonitor 09:19:37 INFO - Cleaning up... 09:19:37 INFO - Return code: 0 09:19:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:19:37 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')]} 09:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:37 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')]} 09:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:37 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 0x7fe8bb760f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17eb230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5090>, '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 0x17e89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e8e40>, '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': '6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843', '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 09:19:37 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 09:19:37 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 09:19:37 INFO - Using env: {'DISPLAY': ':0', 09:19:37 INFO - 'HOME': '/home/cltbld', 09:19:37 INFO - 'LANG': 'en_US.UTF-8', 09:19:37 INFO - 'LANGUAGE': 'en_US:en', 09:19:37 INFO - 'LOGNAME': 'cltbld', 09:19:37 INFO - 'MAIL': '/var/mail/cltbld', 09:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:37 INFO - 'MOZ_NO_REMOTE': '1', 09:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:37 INFO - 'NO_EM_RESTART': '1', 09:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:37 INFO - 'PWD': '/builds/slave/test', 09:19:37 INFO - 'SHELL': '/bin/bash', 09:19:37 INFO - 'SHLVL': '1', 09:19:37 INFO - 'TERM': 'linux', 09:19:37 INFO - 'TMOUT': '86400', 09:19:37 INFO - 'USER': 'cltbld', 09:19:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843', 09:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:37 INFO - '_': '/tools/buildbot/bin/python'} 09:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:38 INFO - Downloading/unpacking jsonschema==2.5.1 09:19:38 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 09:19:38 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 09:19:38 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 09:19:38 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 09:19:38 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 09:19:38 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 09:19:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:19:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:19:40 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 09:19:40 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 09:19:40 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 09:19:40 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 09:19:40 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 09:19:40 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 09:19:40 INFO - Downloading functools32-3.2.3-2.tar.gz 09:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:19:40 INFO - warning: no files found matching '*.txt' 09:19:40 INFO - no previously-included directories found matching 'build' 09:19:40 INFO - no previously-included directories found matching 'dist' 09:19:40 INFO - no previously-included directories found matching '.git*' 09:19:40 INFO - Installing collected packages: jsonschema, functools32 09:19:40 INFO - Running setup.py install for functools32 09:19:40 INFO - warning: no files found matching '*.txt' 09:19:40 INFO - no previously-included directories found matching 'build' 09:19:40 INFO - no previously-included directories found matching 'dist' 09:19:40 INFO - no previously-included directories found matching '.git*' 09:19:40 INFO - Successfully installed jsonschema functools32 09:19:40 INFO - Cleaning up... 09:19:40 INFO - Return code: 0 09:19:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:19:40 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')]} 09:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:40 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')]} 09:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:40 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 0x7fe8bb760f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17eb230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5090>, '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 0x17e89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e8e40>, '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': '6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843', '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 09:19:40 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 09:19:40 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 09:19:40 INFO - Using env: {'DISPLAY': ':0', 09:19:40 INFO - 'HOME': '/home/cltbld', 09:19:40 INFO - 'LANG': 'en_US.UTF-8', 09:19:40 INFO - 'LANGUAGE': 'en_US:en', 09:19:40 INFO - 'LOGNAME': 'cltbld', 09:19:40 INFO - 'MAIL': '/var/mail/cltbld', 09:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:40 INFO - 'MOZ_NO_REMOTE': '1', 09:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:40 INFO - 'NO_EM_RESTART': '1', 09:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:40 INFO - 'PWD': '/builds/slave/test', 09:19:40 INFO - 'SHELL': '/bin/bash', 09:19:40 INFO - 'SHLVL': '1', 09:19:40 INFO - 'TERM': 'linux', 09:19:40 INFO - 'TMOUT': '86400', 09:19:40 INFO - 'USER': 'cltbld', 09:19:40 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843', 09:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:40 INFO - '_': '/tools/buildbot/bin/python'} 09:19:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:19:40 INFO - Cleaning up... 09:19:40 INFO - Return code: 0 09:19:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:19:40 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')]} 09:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:40 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')]} 09:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:40 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 0x7fe8bb760f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17eb230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5090>, '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 0x17e89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e8e40>, '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': '6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843', '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 09:19:40 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 09:19:40 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 09:19:40 INFO - Using env: {'DISPLAY': ':0', 09:19:40 INFO - 'HOME': '/home/cltbld', 09:19:40 INFO - 'LANG': 'en_US.UTF-8', 09:19:40 INFO - 'LANGUAGE': 'en_US:en', 09:19:40 INFO - 'LOGNAME': 'cltbld', 09:19:40 INFO - 'MAIL': '/var/mail/cltbld', 09:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:40 INFO - 'MOZ_NO_REMOTE': '1', 09:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:40 INFO - 'NO_EM_RESTART': '1', 09:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:40 INFO - 'PWD': '/builds/slave/test', 09:19:40 INFO - 'SHELL': '/bin/bash', 09:19:40 INFO - 'SHLVL': '1', 09:19:40 INFO - 'TERM': 'linux', 09:19:40 INFO - 'TMOUT': '86400', 09:19:40 INFO - 'USER': 'cltbld', 09:19:40 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843', 09:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:40 INFO - '_': '/tools/buildbot/bin/python'} 09:19:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:40 INFO - Downloading/unpacking blobuploader==1.2.4 09:19:40 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 09:19:40 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 09:19:40 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 09:19:40 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 09:19:40 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 09:19:40 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 09:19:42 INFO - Downloading blobuploader-1.2.4.tar.gz 09:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:19:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:19:42 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 09:19:42 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 09:19:42 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 09:19:42 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 09:19:42 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 09:19:42 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 09:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:19:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:19:43 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 09:19:43 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 09:19:43 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 09:19:43 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 09:19:43 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 09:19:43 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 09:19:43 INFO - Downloading docopt-0.6.1.tar.gz 09:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:19:43 INFO - Installing collected packages: blobuploader, requests, docopt 09:19:43 INFO - Running setup.py install for blobuploader 09:19:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:19:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:19:43 INFO - Running setup.py install for requests 09:19:44 INFO - Running setup.py install for docopt 09:19:44 INFO - Successfully installed blobuploader requests docopt 09:19:44 INFO - Cleaning up... 09:19:44 INFO - Return code: 0 09:19:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:44 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')]} 09:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:44 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')]} 09:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:44 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 0x7fe8bb760f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17eb230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5090>, '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 0x17e89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e8e40>, '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': '6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843', '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 09:19:44 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 09:19:44 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 09:19:44 INFO - Using env: {'DISPLAY': ':0', 09:19:44 INFO - 'HOME': '/home/cltbld', 09:19:44 INFO - 'LANG': 'en_US.UTF-8', 09:19:44 INFO - 'LANGUAGE': 'en_US:en', 09:19:44 INFO - 'LOGNAME': 'cltbld', 09:19:44 INFO - 'MAIL': '/var/mail/cltbld', 09:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:44 INFO - 'MOZ_NO_REMOTE': '1', 09:19:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:44 INFO - 'NO_EM_RESTART': '1', 09:19:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:44 INFO - 'PWD': '/builds/slave/test', 09:19:44 INFO - 'SHELL': '/bin/bash', 09:19:44 INFO - 'SHLVL': '1', 09:19:44 INFO - 'TERM': 'linux', 09:19:44 INFO - 'TMOUT': '86400', 09:19:44 INFO - 'USER': 'cltbld', 09:19:44 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843', 09:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:44 INFO - '_': '/tools/buildbot/bin/python'} 09:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:44 INFO - Running setup.py (path:/tmp/pip-_xTvpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:44 INFO - Running setup.py (path:/tmp/pip-mIFBCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:44 INFO - Running setup.py (path:/tmp/pip-hhUO0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:44 INFO - Running setup.py (path:/tmp/pip-P9laOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:44 INFO - Running setup.py (path:/tmp/pip-NLg4GW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:44 INFO - Running setup.py (path:/tmp/pip-fGcsdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:44 INFO - Running setup.py (path:/tmp/pip-NEhHxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:44 INFO - Running setup.py (path:/tmp/pip-y78hHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:45 INFO - Running setup.py (path:/tmp/pip-6yoEhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:45 INFO - Running setup.py (path:/tmp/pip-ETpfde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:45 INFO - Running setup.py (path:/tmp/pip-xow5_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:45 INFO - Running setup.py (path:/tmp/pip-v1MoiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:45 INFO - Running setup.py (path:/tmp/pip-YnmJmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:45 INFO - Running setup.py (path:/tmp/pip-zebEri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:45 INFO - Running setup.py (path:/tmp/pip-vJYavH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:45 INFO - Running setup.py (path:/tmp/pip-PlHtzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:45 INFO - Running setup.py (path:/tmp/pip-fNd9Ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:19:45 INFO - Running setup.py install for manifestparser 09:19:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:19:45 INFO - Running setup.py install for mozcrash 09:19:45 INFO - Running setup.py install for mozdebug 09:19:45 INFO - Running setup.py install for mozdevice 09:19:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:19:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:19:46 INFO - Running setup.py install for mozfile 09:19:46 INFO - Running setup.py install for mozhttpd 09:19:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:19:46 INFO - Running setup.py install for mozinfo 09:19:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:19:46 INFO - Running setup.py install for mozInstall 09:19:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:19:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:19:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:19:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:19:46 INFO - Running setup.py install for mozleak 09:19:46 INFO - Running setup.py install for mozlog 09:19:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:19:46 INFO - Running setup.py install for moznetwork 09:19:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:19:46 INFO - Running setup.py install for mozprocess 09:19:47 INFO - Running setup.py install for mozprofile 09:19:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:19:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:19:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:19:47 INFO - Running setup.py install for mozrunner 09:19:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:19:47 INFO - Running setup.py install for mozscreenshot 09:19:47 INFO - Running setup.py install for moztest 09:19:47 INFO - Running setup.py install for mozversion 09:19:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:19:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:19:47 INFO - Cleaning up... 09:19:47 INFO - Return code: 0 09:19:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:47 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 0x7fe8bb760f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17eb230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5090>, '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 0x17e89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e8e40>, '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': '6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843', '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 09:19:47 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 09:19:47 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 09:19:47 INFO - Using env: {'DISPLAY': ':0', 09:19:47 INFO - 'HOME': '/home/cltbld', 09:19:47 INFO - 'LANG': 'en_US.UTF-8', 09:19:47 INFO - 'LANGUAGE': 'en_US:en', 09:19:47 INFO - 'LOGNAME': 'cltbld', 09:19:47 INFO - 'MAIL': '/var/mail/cltbld', 09:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:47 INFO - 'MOZ_NO_REMOTE': '1', 09:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:47 INFO - 'NO_EM_RESTART': '1', 09:19:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:47 INFO - 'PWD': '/builds/slave/test', 09:19:47 INFO - 'SHELL': '/bin/bash', 09:19:47 INFO - 'SHLVL': '1', 09:19:47 INFO - 'TERM': 'linux', 09:19:47 INFO - 'TMOUT': '86400', 09:19:47 INFO - 'USER': 'cltbld', 09:19:47 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843', 09:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:47 INFO - '_': '/tools/buildbot/bin/python'} 09:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:47 INFO - Running setup.py (path:/tmp/pip-hWPCJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:47 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)) 09:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:47 INFO - Running setup.py (path:/tmp/pip-eO6K40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:47 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)) 09:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:47 INFO - Running setup.py (path:/tmp/pip-fngUrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:48 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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:48 INFO - Running setup.py (path:/tmp/pip-f1l4z7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:48 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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:48 INFO - Running setup.py (path:/tmp/pip-KuTYbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:48 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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:48 INFO - Running setup.py (path:/tmp/pip-saX7Nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:48 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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:48 INFO - Running setup.py (path:/tmp/pip-fWPjPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:48 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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:48 INFO - Running setup.py (path:/tmp/pip-Ro3LGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:48 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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:48 INFO - Running setup.py (path:/tmp/pip-pC7Bri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:48 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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:48 INFO - Running setup.py (path:/tmp/pip-yPoEkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:48 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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:48 INFO - Running setup.py (path:/tmp/pip-73JfVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:48 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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:48 INFO - Running setup.py (path:/tmp/pip-g1gI1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:48 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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:48 INFO - Running setup.py (path:/tmp/pip-XzAw_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:48 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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:48 INFO - Running setup.py (path:/tmp/pip-bztRHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:48 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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:48 INFO - Running setup.py (path:/tmp/pip-qrm3YB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:48 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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:48 INFO - Running setup.py (path:/tmp/pip-819csG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:48 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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:48 INFO - Running setup.py (path:/tmp/pip-t0XT_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:49 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)) 09:19:49 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)) 09:19:49 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)) 09:19:49 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)) 09:19:49 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)) 09:19:49 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)) 09:19:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:19:49 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 09:19:49 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 09:19:49 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 09:19:49 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 09:19:49 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 09:19:49 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 09:19:50 INFO - Downloading blessings-1.6.tar.gz 09:19:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:19:51 INFO - Installing collected packages: blessings 09:19:51 INFO - Running setup.py install for blessings 09:19:51 INFO - Successfully installed blessings 09:19:51 INFO - Cleaning up... 09:19:51 INFO - Return code: 0 09:19:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:19:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:51 INFO - Reading from file tmpfile_stdout 09:19:51 INFO - Current package versions: 09:19:51 INFO - argparse == 1.2.1 09:19:51 INFO - blessings == 1.6 09:19:51 INFO - blobuploader == 1.2.4 09:19:51 INFO - docopt == 0.6.1 09:19:51 INFO - functools32 == 3.2.3-2 09:19:51 INFO - jsonschema == 2.5.1 09:19:51 INFO - manifestparser == 1.1 09:19:51 INFO - mozInstall == 1.12 09:19:51 INFO - mozcrash == 0.17 09:19:51 INFO - mozdebug == 0.1 09:19:51 INFO - mozdevice == 0.48 09:19:51 INFO - mozfile == 1.2 09:19:51 INFO - mozhttpd == 0.7 09:19:51 INFO - mozinfo == 0.9 09:19:51 INFO - mozleak == 0.1 09:19:51 INFO - mozlog == 3.3 09:19:51 INFO - moznetwork == 0.27 09:19:51 INFO - mozprocess == 0.23 09:19:51 INFO - mozprofile == 0.28 09:19:51 INFO - mozrunner == 6.12 09:19:51 INFO - mozscreenshot == 0.1 09:19:51 INFO - mozsystemmonitor == 0.3 09:19:51 INFO - moztest == 0.7 09:19:51 INFO - mozversion == 1.4 09:19:51 INFO - psutil == 3.1.1 09:19:51 INFO - requests == 1.2.3 09:19:51 INFO - wsgiref == 0.1.2 09:19:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:51 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 0x7fe8bb760f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17eb230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5090>, '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 0x17e89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e8e40>, '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': '6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843', '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 09:19:51 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 09:19:51 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 09:19:51 INFO - Using env: {'DISPLAY': ':0', 09:19:51 INFO - 'HOME': '/home/cltbld', 09:19:51 INFO - 'LANG': 'en_US.UTF-8', 09:19:51 INFO - 'LANGUAGE': 'en_US:en', 09:19:51 INFO - 'LOGNAME': 'cltbld', 09:19:51 INFO - 'MAIL': '/var/mail/cltbld', 09:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:51 INFO - 'MOZ_NO_REMOTE': '1', 09:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:51 INFO - 'NO_EM_RESTART': '1', 09:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:51 INFO - 'PWD': '/builds/slave/test', 09:19:51 INFO - 'SHELL': '/bin/bash', 09:19:51 INFO - 'SHLVL': '1', 09:19:51 INFO - 'TERM': 'linux', 09:19:51 INFO - 'TMOUT': '86400', 09:19:51 INFO - 'USER': 'cltbld', 09:19:51 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843', 09:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:51 INFO - '_': '/tools/buildbot/bin/python'} 09:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:51 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)) 09:19:51 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)) 09:19:51 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)) 09:19:51 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)) 09:19:51 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)) 09:19:51 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)) 09:19:51 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)) 09:19:51 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)) 09:19:51 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)) 09:19:51 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)) 09:19:51 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)) 09:19:51 INFO - Cleaning up... 09:19:51 INFO - Return code: 0 09:19:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8bb760f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17eb230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5090>, '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 0x17e89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e8e40>, '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': '6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843', '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 09:19:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:19:51 INFO - Using env: {'DISPLAY': ':0', 09:19:51 INFO - 'HOME': '/home/cltbld', 09:19:51 INFO - 'LANG': 'en_US.UTF-8', 09:19:51 INFO - 'LANGUAGE': 'en_US:en', 09:19:51 INFO - 'LOGNAME': 'cltbld', 09:19:51 INFO - 'MAIL': '/var/mail/cltbld', 09:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:51 INFO - 'MOZ_NO_REMOTE': '1', 09:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:51 INFO - 'NO_EM_RESTART': '1', 09:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:51 INFO - 'PWD': '/builds/slave/test', 09:19:51 INFO - 'SHELL': '/bin/bash', 09:19:51 INFO - 'SHLVL': '1', 09:19:51 INFO - 'TERM': 'linux', 09:19:51 INFO - 'TMOUT': '86400', 09:19:51 INFO - 'USER': 'cltbld', 09:19:51 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843', 09:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:51 INFO - '_': '/tools/buildbot/bin/python'} 09:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:19:51 INFO - Cleaning up... 09:19:51 INFO - Return code: 0 09:19:51 INFO - Running post-action listener: _resource_record_post_action 09:19:51 INFO - Running post-action listener: _start_resource_monitoring 09:19:51 INFO - Starting resource monitoring. 09:19:51 INFO - [mozharness: 2016-08-31 16:19:51.900956Z] Finished create-virtualenv step (success) 09:19:51 INFO - [mozharness: 2016-08-31 16:19:51.901420Z] Running install step. 09:19:51 INFO - Running pre-action listener: _resource_record_pre_action 09:19:51 INFO - Running main action method: install 09:19:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:52 INFO - Reading from file tmpfile_stdout 09:19:52 INFO - Detecting whether we're running mozinstall >=1.0... 09:19:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:19:52 INFO - Reading from file tmpfile_stdout 09:19:52 INFO - Output received: 09:19:52 INFO - Usage: mozinstall [options] installer 09:19:52 INFO - Options: 09:19:52 INFO - -h, --help show this help message and exit 09:19:52 INFO - -d DEST, --destination=DEST 09:19:52 INFO - Directory to install application into. [default: 09:19:52 INFO - "/builds/slave/test"] 09:19:52 INFO - --app=APP Application being installed. [default: firefox] 09:19:52 INFO - mkdir: /builds/slave/test/build/application 09:19:52 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'] 09:19:52 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 09:20:08 INFO - Reading from file tmpfile_stdout 09:20:08 INFO - Output received: 09:20:08 INFO - /builds/slave/test/build/application/firefox/firefox 09:20:08 INFO - Running post-action listener: _resource_record_post_action 09:20:08 INFO - [mozharness: 2016-08-31 16:20:08.341458Z] Finished install step (success) 09:20:08 INFO - [mozharness: 2016-08-31 16:20:08.341737Z] Running run-tests step. 09:20:08 INFO - Running pre-action listener: _resource_record_pre_action 09:20:08 INFO - Running main action method: run_tests 09:20:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:20:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:20:08 INFO - Python 2.7.3 09:20:08 INFO - Return code: 0 09:20:08 INFO - grabbing minidump binary from tooltool 09:20:08 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')]} 09:20:08 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 0x17e5090>, '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 0x17e89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e8e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:20:08 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 09:20:08 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 09:20:08 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 09:20:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:20:08 INFO - Return code: 0 09:20:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:20:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:20:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:20:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:20:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:20:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:20:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:20:08 INFO - Using env: {'DISPLAY': ':0', 09:20:08 INFO - 'HOME': '/home/cltbld', 09:20:08 INFO - 'LANG': 'en_US.UTF-8', 09:20:08 INFO - 'LANGUAGE': 'en_US:en', 09:20:08 INFO - 'LOGNAME': 'cltbld', 09:20:08 INFO - 'MAIL': '/var/mail/cltbld', 09:20:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:20:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:08 INFO - 'MOZ_NO_REMOTE': '1', 09:20:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:08 INFO - 'NO_EM_RESTART': '1', 09:20:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:08 INFO - 'PWD': '/builds/slave/test', 09:20:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:20:08 INFO - 'SHELL': '/bin/bash', 09:20:08 INFO - 'SHLVL': '1', 09:20:08 INFO - 'TERM': 'linux', 09:20:08 INFO - 'TMOUT': '86400', 09:20:08 INFO - 'USER': 'cltbld', 09:20:08 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843', 09:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:08 INFO - '_': '/tools/buildbot/bin/python'} 09:20:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:20:08 INFO - mozversion application_buildid: 20160831075920 09:20:08 INFO - mozversion application_changeset: b3ec8a3373e8faca26c39e9ff577a2d4f8b6927a 09:20:08 INFO - mozversion application_display_name: Nightly 09:20:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:20:08 INFO - mozversion application_name: Firefox 09:20:08 INFO - mozversion application_remotingname: firefox 09:20:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:20:08 INFO - mozversion application_vendor: Mozilla 09:20:08 INFO - mozversion application_version: 51.0a1 09:20:08 INFO - mozversion platform_buildid: 20160831075920 09:20:08 INFO - mozversion platform_changeset: b3ec8a3373e8faca26c39e9ff577a2d4f8b6927a 09:20:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:20:08 INFO - mozversion platform_version: 51.0a1 09:20:08 INFO - using testdate: 1472660408 09:20:08 INFO - actual date: 1472660408 09:20:08 INFO - starting webserver on 'localhost:58488' 09:20:08 INFO - SUITE-START | Running 2 tests 09:20:08 INFO - TEST-START | dromaeo_css 09:20:08 INFO - operating with platform_type : linux_ 09:20:08 INFO - Initialising browser for dromaeo_css test... 09:20:08 INFO - TEST-INFO | started process 26173 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGjaCvr/profile http://localhost:58488/getInfo.html) 09:20:13 INFO - PROCESS | 26173 | __metrics Screen width/height:1600/1200 09:20:13 INFO - PROCESS | 26173 | colorDepth:24 09:20:13 INFO - PROCESS | 26173 | Browser inner width/height: 1024/697 09:20:13 INFO - PROCESS | 26173 | __metrics 09:20:13 ERROR - PROCESS | 26173 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 09:20:14 INFO - TEST-INFO | 26173: exit 0 09:20:14 INFO - Browser initialized. 09:20:14 INFO - Running cycle 1/1 for dromaeo_css test... 09:20:14 INFO - TEST-INFO | started process 26293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGjaCvr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:27 INFO - PROCESS | 26293 | RSS: Main: 193003520 09:20:27 INFO - PROCESS | 26293 | 09:21:16 INFO - PROCESS | 26293 | 1472660476900 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] 09:23:29 INFO - PROCESS | 26293 | Cycle 1(1): loaded http://localhost:58488/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58488/tests/dromaeo/cssquery-ext.html) 09:23:31 INFO - PROCESS | 26293 | RSS: Main: 211214336 09:23:31 INFO - PROCESS | 26293 | 09:26:33 INFO - PROCESS | 26293 | Cycle 1(1): loaded http://localhost:58488/tests/dromaeo/cssquery-ext.html (next: http://localhost:58488/tests/dromaeo/cssquery-jquery.html) 09:26:34 INFO - PROCESS | 26293 | RSS: Main: 206958592 09:26:34 INFO - PROCESS | 26293 | 09:29:36 INFO - PROCESS | 26293 | Cycle 1(1): loaded http://localhost:58488/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58488/tests/dromaeo/cssquery-mootools.html) 09:29:36 INFO - PROCESS | 26293 | RSS: Main: 202436608 09:29:36 INFO - PROCESS | 26293 | 09:32:38 INFO - PROCESS | 26293 | Cycle 1(1): loaded http://localhost:58488/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58488/tests/dromaeo/cssquery-prototype.html) 09:32:39 INFO - PROCESS | 26293 | RSS: Main: 195424256 09:32:39 INFO - PROCESS | 26293 | 09:35:42 INFO - PROCESS | 26293 | Cycle 1(1): loaded http://localhost:58488/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58488/tests/dromaeo/cssquery-yui.html) 09:35:43 INFO - PROCESS | 26293 | RSS: Main: 199831552 09:35:43 INFO - PROCESS | 26293 | 09:38:45 INFO - PROCESS | 26293 | Cycle 1(1): loaded http://localhost:58488/tests/dromaeo/cssquery-yui.html (next: http://localhost:58488/tests/dromaeo/cssquery-dojo.html) 09:38:45 INFO - PROCESS | 26293 | RSS: Main: 200597504 09:38:45 INFO - PROCESS | 26293 | 09:38:45 INFO - PROCESS | 26293 | __start_tp_report 09:38:45 INFO - PROCESS | 26293 | _x_x_mozilla_page_load 09:38:45 INFO - PROCESS | 26293 | _x_x_mozilla_page_load_details 09:38:45 INFO - PROCESS | 26293 | |i|pagename|runs| 09:38:45 INFO - PROCESS | 26293 | |0;dojo.html;2635.367511797169;2662.32110811743;2674.9866250668742;2675.1172113202633;2682.7049024607277;4755.381800365947;4829.37218161639;4856.174450343441;4889.7555122243875;4972.378452693413;4755.048990201964;4773.594244489213;4837.612990960714;4870.099031679142;4875.268709693548;4398.912021759563;4472.463304403476;4473.7986790594505;4577.542245775412;4588;4495.752733599651;4511.345854851061;4568.725876447407;4587.816487340502;4594.65540084495;4290.399344091829;4329.069250111241;4391.494978077498;4408.515063343029;4455.108978204372;4349.847755328548;4363.716358436692;4392.626626736731;4463.642908567307;4481.865544033684;4399.1641588098155;4402.51572327047;4409.074094440171;4415.66882483815;4484.8878778030485;4722.480527142012;4797.880052998668;4804.23132298834;4823.589994850442;4828.927566086476;5139.383274007143;5152.871178220575;5157.432682404932;5157.767900444452;5227.634065615409;5113.360829896263;5140.948590514085;5181.145111056671;5181.792728290864;5183.688978661255;4723.031778485437;4760.262159365304;4760.500147484534;4793.18515852306;4822.228443449031;5288.2596436498925;5304.496072873071;5313.814016509404;5328.280682107943;5337.412884582693;5070.036693028386;5102.617303702237;5111.514406131411;5118.10433174193;5174.7153906535505;5030.547250747377;5069.670471419346;5201.947980520146;5211.42674305826;5219.817306394258;5159.742012899415;5159.7678104485385;5174.068667639785;5191;5214.7914083436235;5120.462351453044;5120.897582048413;5135.87160320995;5137.101007323703;5193.091209038479;4301.698881078294;4370.912581748347;4390.714603550823;4393.011572396249;4417.491988421309;3811.866584669523;3814.1799513104816;3828.75113117652;3849.4995650565247;3860.942085868714;4432.224360736858;4432.534583868712;4438.755868427267;4445.977770111193;4469.843555475542;5061.392632884077;5148.871278218;5176.792928282902;5220.660657057279;5234.581233501311;4439.289713645801;4465.173942820588;4471.038726673716;4509.368688383629;4523.389342438729;4693.718376897397;4697.95302046982;4707.270373092176;4714.81140754366;4761.714297142183;4685.742284174403;4758.262469317261;4774.689645173053;4827.565519103297;4871.780769865435;5124.180131178993;5138.306328645585;5150.665206761549;5152.819651312186;5201.557867581298;4803.255495398219;4803.351547541037;4806.2310030394965;4815.662903596714;4852.75736213195;4958.776855041459;5088.338515992898;5164.7417629119145;5179.067767801681;5233.293505376878;5191;5197.974010129925;5211.973940130275;5216.061109000417;5251.186066159751;5092.6435149539175;5097.235414687826;5098.133317336136;5098.643094983316;5171.45699701541;4871.488493708252;4961.677490963076;4965.4041515018425;4966.379202599675;5037.949620503895;4862.222044472867;4874.780634871368;4959.305697202467;4960.553550180501;5011.373578302712;5065.518775716301;5078.136716758234;5084.593232541314;5085.186370180753;5097.490250974873;4854.126257273583;4954.826581069645;5002.324686167321;5007.29897814299;5012 09:38:45 INFO - PROCESS | 26293 | |1;ext.html;551.619382625988;551.6689986008395;558.8602849287678;563.3633993587246;587.8412828536298;34859.30281394371;38793.41809872854;38873.61126388735;38977.025574360654;39057.414138787906;38936.22127557447;39101.21797564054;39506.40740388897;39614;39676.20647587054;7670.731524396633;7805.687772489122;7822.061352637691;7825.060992680857;7829.334506566948;7638.465307428482;7726.150123486412;7727.8068048298965;7729.34300584451;7733.574653394061;7662.6934922603305;7725.18885517021;7730.149683534834;7781.3385862201785;7786.26030527099;7694.384449244103;7704.730334438268;7709.922900770976;7775.766726998199;7787.06555213378;7633.923660763432;7696.268854458817;7712.9614351927885;7733.7679869604;7735.071791385014;37261.44107838358;37342.62657373419;37477.250454990746;37659.81170094132;37730.43404348937;3088.8146711197173;3119.7192252697364;3139.764517661162;3169.4453470642775;3492.528508651325;28664.570031449544;28838.279043023882;28922;29095;29498;3282.3763484937786;3294.58817647794;3296.1430028192844;3345.9498107528407;3393.100828280508;166698;168022;168326.99999999878;168408;168439;31178.258608966615;32259.67740322614;54107.45892541103;54192.45807541953;54759.726201368736;32712.83643581767;33150;33336;33464.16339591481;33573.49639755406;13863.861361386256;13929.512467063603;13943.651408714863;14030.438782448791;14086.436542538184;11573.942130289295;11579.073674106052;11596.304221746723;11602.18784685064;11608.941955290169;7759.844803103906;7809.2190780921455;7840.490368126054;7874.133845277015;7899.605019748989;3036.8481575921114;3054.2517083314287;3071.1400807773857;3078.291992841659;3090.1656552731088;825.3644693585906;915.272358475014;921.4931787516839;924.8300899362312;990.5047476261869;27433.725662743516;28036.43927121446;28176.43647127046;28550.857245714054;28700.569491457645;899.5996781432331;956.3114557518576;993.2054356514759;997.3244948486612;999.9100080992746;14447.711045779026;14612.707745845024;14701.926490367694;14909.850901491063;15160;367639;368340;369261;371821;372507;48957.265641015416;49245.50754492481;49274.75362623164;49347.50652493501;49548.75225623849;1141.4920360439526;1182.5565412970136;1186.1341220908612;1189.0665827325681;1191.7259030423052;25746.742532575183;26299.21102366932;27117.593236101868;27541;27597.75810088511;37322;37445.81277093706;37446.812765935996;37480.250394992494;37538;313088;313581;314430;314561;314991;25238.49523009566;25491;25613.359666007753;25637.615435768104;25692;41567.792161039004;42023.57976420197;42265;42496.78751606222;43033.13933721371;35085.29829403449;35727.64272357243;35746;35893.64106358903;35929;35828.462573060904;36316.636833631324;36346.8182659085;36404.81797591101;36449.27101458009;34538.82730586331;34749.82625086858;35275.470867936485;35569.82215088908;35650;30739.692603073683;32557.674423255463;33151;33231.833840830644;33401.16497087592;24897.25308240756;25274.36814079663;25310.620340694535;25704.228873133838;25892.22323330303 09:38:45 INFO - PROCESS | 26293 | |2;jquery.html;361.1783193235389;362.711644242827;369.87054530914185;377.58465687743467;379.16394350457244;15855.920720396396;16071.598210044755;17035.318587256494;17098.230579623916;17134.82865171348;14329;16292.755608665879;16828.915855420735;16844.32622695094;16955.660886782258;4856.927146092811;5097.770600322994;5105.540501354877;5106.055379754739;5106.846794596168;4899.8775030624165;4939.67892087015;4973.651844370896;4980.651354405193;4984.4018717753925;4976.4774698656665;5022.522860328263;5028.49715028496;5165.81919632813;5179.326687530615;5113.284140220372;5143.922841157386;5152.458991805844;5162.6902385856965;5173.249878767595;4345.435093437864;4425.491068527129;4443.4445694288215;4498.167838949772;4501.369808226851;14207.85792142086;14356;19092;19349.226030958886;19475.220991160335;1873.3911478769455;1887.7168424736262;2057;2177.3250292409402;2280.7719228077226;13286.53497127596;13398.464061437531;13582.456701731919;13613.931930340284;13785.655358616015;1731.5151757507917;1774.6716857381296;1799.3072667023291;1816.0465755478479;1825.3611236067402;66896.3310366895;67788;67979.66010169918;68560.6571967137;69281.65359173172;9445.90554094464;9598.808023839623;9740.707778766648;9748.220142388735;10032.899671003197;13326.533571324957;13333.20000799955;13346.799798003038;13354.198748075147;13365.866341336656;7254.818629534304;7426;7459.216782237895;7602.46782725204;7708.884366734504;7269.382102521345;7330.083739532559;7432.702691892372;7491.513051651626;7552.320291173821;5887.381824908409;5950.642961422329;6017.398260173947;6084.202061410807;6169.0259117082105;1748.833860783249;1758.5691505581215;1764.461839139075;1809.1044932758368;1829.9268029278946;821.9876701849477;831.9251267385844;842.9662813487514;860.5740158621522;945.5272363818091;16719;16756.413525526546;16841.915790420968;17299.13504324779;18102.45692629223;837.8240569480478;843.2832092721261;847.0978407995465;915.8259930613162;943.3113826906397;9616;9806.607735690492;9876.604935802487;9946.154576860903;10003.199744020461;384215;400906;401983;402902;405325;81693.59153204196;82417.58791206006;83618.5819070913;85251;85347.57326213329;909.1226965977995;937.9822892161944;956.2923436656824;966.7534778631403;966.8356379415376;12293.508259669514;14496.565103046925;15285;15299.235038248265;16068;37301.81349093237;37333.81333093426;37513.2497350046;38489.80755096207;40056.3991540133;52606.73696631492;52885.7355713219;54083.647908802595;54429;55686.44313556812;7494.250574942462;7775.339096176662;7925.445218834626;7996;8092.048669640205;9969;11114.666560003212;11222.979863624625;11607.30356178632;12594.181378210387;10225.795484090426;10378.740531486774;10473.68578942633;10562.260641755003;10710.196735244732;4547.431571053618;6260.655663938527;10459.58161673555;10507.527161277914;10593;10079.294449388766;10113.24150688716;10218.437985910548;10604.840927385942;10738.248322617654;7672.462927595015;7848.7645370638975;7958.164392738679;7989.600519974094;7997.160298168841;9684.176844967975;9775.364601300893;9855.21158307348;10264.230182736175;10452.32059916103 09:38:45 INFO - PROCESS | 26293 | |3;mootools.html;1358.796180572914;1385.8198434203553;1471.7939488471616;1629.9266533006014;1692.6699293637746;6861.725530978755;7493.775186744399;7645.082590089197;8134.837303253938;8152.307053900418;7807.453478256524;8039.075506316775;8055.798605034877;8064.193580641948;8073.354131669467;2206.117552978805;2239.104358256702;2253.0537174386795;2254.0532976149975;2260.3445000949705;2202.174184680745;2234.218023691711;2288.5079707862806;2291.3698732848434;2292.0373443153917;2240.271911628719;2255.052877791323;2264.320703788865;2267.8639281643154;2273.863568185906;2187.8687278763327;2198.8021078102965;2201.7137772089527;2202.0861342542826;2202.812760915324;2200.5378870437225;2206.1837120265604;2206.5366273082514;2207.415035015722;2218.456478162844;7990.720324788605;8055.959720201361;8089.069756977964;8090.635921383552;8124.796880077986;4589;4738.691985020962;4740.786664600101;4740.881477963044;4743.810247590092;2960.422717570075;3025.1378357168323;3187.984060079708;3192.058342788883;3193.3613277344393;984.3798407003542;992.3103443107043;1001.8447140693131;1018.801333739921;1022.0443884967505;10817.242793004492;10964.17768667353;10966.725831854268;11002.174836887265;11013.504392302366;4228.323468245066;4321.7406955582765;4461.196984542748;4476.977615111904;4533.370645025943;8441.57792110392;8446.66213351459;8450.957745211235;8507.319414446829;8514.361422893184;4691.272852707836;4708.764561771898;4724.244120940702;4730.692504987165;4738.573528382462;3666;4128.525219599785;4218.915621687549;4416.271315233015;4422.557744225552;3512.2448673535314;3512.350215210194;3590.6588874056924;3631.1648320886343;3747.4378843173195;1053.5575058475306;1084.902358787697;1085.7394225385851;1093.327603523827;1094.2668412163869;776.3168411797695;818.4393690322148;847.9993607543036;852.1733918099434;857.8027053777666;5177.909710323919;5239.711815850089;5240.732425285591;5321.068812957717;5409.5131438169965;421.43317238314415;423.0629156418548;427.04981416348375;427.2906974422444;429.15884865663025;3475.42655461851;3572.1248294168095;3587.4798154268005;3633.509476220729;3649.1606930406156;9306.162445379812;9736.075072868067;9760.121589057018;9763.267754918268;9807.117359437685;9755.317127801127;9803.068708472683;9821.410715356958;9824.508774561386;9835.655752048644;7261.38278246355;7297.744578939818;7372.778816635509;7465.962670186615;7474.3273105419685;5245.763940622757;5312.867178320573;5313.362396512443;5328.760205790826;5385.946140538701;8868.733937981871;8979.55102244872;9011.774705632411;9025.277977761894;9037;8927.598258078273;9156.175944165057;9195.850518685163;9201.907980920372;9300.953495232481;5591.21722958778;6178.104174894705;6349.809505714836;6390;6494.805155845333;7704.8459030820195;7777.766666999999;7862.253085956825;7892.210778922062;7898.644560994654;6727.629980351127;6893.655317234218;6897.172339319314;6898.379145876896;7077.469189810888;6582.572132811352;6608.636524991171;6638.933610664025;6657.700403481952;6884.449244060363;6002.579819412774;6226.937730622817;6285.59143655661;6298.118263443213;6314.147590075281;4543.750093744876;4547.045120524727;4558.247889098262;4621.514740952286;4650.116477869194;4548.681592288508;4655.2784318430695;4714.717116972993;4765.166095933128;4937.23472861707 09:38:45 INFO - PROCESS | 26293 | |4;prototype.html;297.5848691075949;302.20670739309315;308.85483822603373;310.821277765285;312.375249500998;4868.17443458703;4977.278294647274;5052.39371275447;5092.465291144432;5117.641765076446;4974.527419895104;5026;5029.170186919163;5031.723255220962;5043.445221025684;3950.980245098785;3972.3247048001763;3974.132157885789;3984.561698213194;3988.202359528106;3919.764814111148;3925.6466917977377;3986.6013398660193;3990.221906728175;3993.5207775067033;3932.488776459071;3955.782431966241;3966.1869316790135;3969.2260009298197;3970.50368703912;3938.7636741795586;3968.444417781513;3975.6819454443576;3982.323005089156;3985.681145508381;3466.7746596471147;3491.4064609016527;3499.492573576817;3500.2299494111253;3504.4217704078796;4683;4972.950270497285;4984.3021976923255;5024.497550244982;5028.069807085664;4462.754548499831;4476.84331048415;4479.3057076153245;4484.282514797616;4486.820527178909;5222.127829693653;5245.554127899133;5248.973755131238;5263.26314315996;5345.679259244458;3596.5504311961004;3687.5943646199166;3697.500837386945;3703.7222208334483;3716.888493345204;5491.258680078218;5497.780088796443;5504.2294078829;5533.529649979757;5586.374404030099;3832.4442955771256;3834.309824231609;3839.424086387064;3839.9040023999064;3848.7113466490127;3746.831392587286;3891.221755648825;3894.5521265054313;3898.863539776094;3900.4929359183125;4364.127174565099;4392.494863090786;4393.780310984438;4437.092050418351;4442.800073996613;5211.478852114834;5245.868853278698;5253.50091741284;5256.185291279781;5363.839084827461;1265.6835791052238;1293.8835504804613;1317.124112465219;1325.4830616059744;1333.1068184316532;866.2117473099449;873.6854732296368;902.6028547439106;905.1401168889581;909.8271328447573;4648.5119062498625;4648.721076735339;4650.209464390994;4657.347971284023;4669;5447.509724124848;5454.672719636835;5461.972690136524;5466.234727138204;5476.370217424967;4381.364702118175;4650.9767451162525;4658.510856360033;4660.324252983299;4673.626109911199;2491.6885389326335;2524.911628093008;2545.790749394023;2556.6548515950108;2565.871706414709;4516.645006498037;4544.7045942013665;4549.863504094882;4552.658550608718;4560.4527456704745;4665.766711664403;4900;4902.607791376681;4916.72957987307;4935.777889994959;4460.687751857404;4500.257457519473;4513.842015529441;4536.977315113403;4545.3863728396245;4787.95212047889;4825.490744812608;4831.492693267156;4838.177509823409;4843.975780121077;4581.679282450196;4724.149653062482;4733.242681170997;4738.649484896788;4760.2625041860165;4532.776150439428;4536.319552067216;4543.522930092425;4565.223911935045;4598.724076555283;3464.116650254169;3466.497357883143;3468.289000754789;3481.47777833327;3486.302739452069;4816.675414261106;4817;4840.201366774443;4854.296127061486;5265.631405801557;5179.974100129475;5323.707196104251;5334.75993580282;5335.573154147736;5346.1713434417725;5324;5324.707141107121;5332.493413125747;5337.466253374631;5343.251944727819;5085.4914508548845;5235.842924712265;5247.921281180862;5261.815836445706;5292.814751483679;5351.331083614548;5365.812196573102;5368.812091576776;5369.27514785499;5386.811461598825;5171.456997015259;5230.843074707765;5245.527902488794;5266.789328426973;5285.973570132125 09:38:45 INFO - PROCESS | 26293 | |5;yui.html;633.2907143998721;679.6397909108174;733.5195446982228;735.6174789109659;749.8687729647314;12637.368131593417;12839.679008024805;13053.477860885554;13985;14002.369893354798;13378.73242535151;13647.590572282823;13648.454061837514;13658.248796316198;13690.589282321522;623.4638211138417;756.648158606248;777.6383981448625;778.7663700889739;782.5695867273006;743.8252010777463;776.3711393771064;783.6121120045585;784.3725019984018;785.6071964017991;826.0830478169257;828.1221904780951;828.4739190613943;829.5354601423222;831.5177197225595;823.275517544563;823.7446391618618;824.171707434031;824.5464994253197;824.7484517222244;599.0385431382612;603.2881200183781;604.9425304596057;605.2041565341606;605.5367643752533;13275.402606882617;13283.734325313537;13283.800742988862;13295.53465628708;13379.531716389976;13480.865191348059;13515.66210844727;13835.79246311306;14043.859561404357;14173.149611023371;10655.30740501865;10792.51433685486;10863.18526110545;10908.890911090946;10941.945290273497;3316.6185888622636;3346.598408191033;3351.2962277921665;3406.267652454734;3471.4966329882277;62281;63676.363236367506;64023;64172;65383.3461665382;10883.052991146515;10948.233623646269;10949.562017519369;11071;11160.609378671708;20664.276750313667;20722.378328650164;20818.375448736562;20830.895845520674;20869;6980.895286570705;6990.196127445307;7070.787876363717;7121.323474269936;7246.673899674527;3540.6990405815277;3722.4602432647657;3754.249150169977;3757.9248415031548;3834;2968.4805159097073;3070.9078727638207;3088;3090.799098058619;3102.1624161476275;528.2498851630617;529.933758280215;542.2977244468423;545.9344878614592;549.9340079190442;489.79918233524086;537.2156651289083;557.2059814763945;567.9379560222411;572.6592677356966;7583.848323033509;7609;7847.803804904809;7897.3287270581495;8133.589802366064;461.4278294914349;495.56142813610217;553.4493179286635;580.6516090345843;581.5347721822525;3621.3662609043313;3786.905327366783;3799.35410980134;3862.1310205204168;3953.1105501261986;56427;56587.71706141443;56978.43021569814;57125;94138;83540;84138;86528;87279.56360218159;88474.55762721146;77508;78084.21915780882;78562.60718696484;80315.59842200752;83935.580322098;6941.305869413019;7497.362724168507;7527.322540971339;7625.6949722010495;7737.419693522896;45345.319820202065;45354.319685204086;46127.53872461232;46155.76922115368;47503.99999999862;64137.67931160314;66247.66876165588;66591.33408665852;67817;68065;8949.32880033987;8984.640614375614;9568.569414376509;9753.170980466455;9772.511374431393;10779.13766898662;10950.56197752081;11091.112710983263;11342.60300889465;11766.529338826693;10393.584256629953;10420.06219440254;10523.421211833116;10734.892651073389;10773.946130269298;10048.497575121068;10212.234082443994;10374.429406382722;10529.526171322155;10597.523111459848;9566.520165846106;9714.077162669535;9715.465649389069;9864.506774661095;9929.65246216379;8329.042160151417;8482.830343392974;8569.657213711382;8634.525101119247;8964.596593153454;8470.5106293662;8580.785480363042;8956.476140534714;9079.273658107468;9128.315376346667 09:38:45 INFO - PROCESS | 26293 | __end_tp_report 09:38:45 INFO - PROCESS | 26293 | __start_cc_report 09:38:45 INFO - PROCESS | 26293 | _x_x_mozilla_cycle_collect,356 09:38:45 INFO - PROCESS | 26293 | __end_cc_report 09:38:45 INFO - PROCESS | 26293 | __startTimestamp1472661525975__endTimestamp 09:38:45 INFO - PROCESS | 26293 | 09:38:45 INFO - PROCESS | 26293 | ------- Summary: start ------- 09:38:45 INFO - PROCESS | 26293 | Number of tests: 6 09:38:45 INFO - PROCESS | 26293 | 09:38:45 INFO - PROCESS | 26293 | [#0] dojo.html Cycles:165 Average:4774.72 Median:4870.10 stddev:505.38 (10.4%) stddev-sans-first:478.25 09:38:45 INFO - PROCESS | 26293 | Values: 2635.4 2662.3 2675.0 2675.1 2682.7 4755.4 4829.4 4856.2 4889.8 4972.4 4755.0 4773.6 4837.6 4870.1 4875.3 4398.9 4472.5 4473.8 4577.5 4588.0 4495.8 4511.3 4568.7 4587.8 4594.7 4290.4 4329.1 4391.5 4408.5 4455.1 4349.8 4363.7 4392.6 4463.6 4481.9 4399.2 4402.5 4409.1 4415.7 4484.9 4722.5 4797.9 4804.2 4823.6 4828.9 5139.4 5152.9 5157.4 5157.8 5227.6 5113.4 5140.9 5181.1 5181.8 5183.7 4723.0 4760.3 4760.5 4793.2 4822.2 5288.3 5304.5 5313.8 5328.3 5337.4 5070.0 5102.6 5111.5 5118.1 5174.7 5030.5 5069.7 5201.9 5211.4 5219.8 5159.7 5159.8 5174.1 5191.0 5214.8 5120.5 5120.9 5135.9 5137.1 5193.1 4301.7 4370.9 4390.7 4393.0 4417.5 3811.9 3814.2 3828.8 3849.5 3860.9 4432.2 4432.5 4438.8 4446.0 4469.8 5061.4 5148.9 5176.8 5220.7 5234.6 4439.3 4465.2 4471.0 4509.4 4523.4 4693.7 4698.0 4707.3 4714.8 4761.7 4685.7 4758.3 4774.7 4827.6 4871.8 5124.2 5138.3 5150.7 5152.8 5201.6 4803.3 4803.4 4806.2 4815.7 4852.8 4958.8 5088.3 5164.7 5179.1 5233.3 5191.0 5198.0 5212.0 5216.1 5251.2 5092.6 5097.2 5098.1 5098.6 5171.5 4871.5 4961.7 4965.4 4966.4 5037.9 4862.2 4874.8 4959.3 4960.6 5011.4 5065.5 5078.1 5084.6 5085.2 5097.5 4854.1 4954.8 5002.3 5007.3 5012.0 09:38:45 INFO - PROCESS | 26293 | 09:38:45 INFO - PROCESS | 26293 | [#1] ext.html Cycles:180 Average:43036.43 Median:35787.23 stddev:78365.90 (219.0%) stddev-sans-first:78520.81 09:38:45 INFO - PROCESS | 26293 | Values: 551.6 551.7 558.9 563.4 587.8 34859.3 38793.4 38873.6 38977.0 39057.4 38936.2 39101.2 39506.4 39614.0 39676.2 7670.7 7805.7 7822.1 7825.1 7829.3 7638.5 7726.2 7727.8 7729.3 7733.6 7662.7 7725.2 7730.1 7781.3 7786.3 7694.4 7704.7 7709.9 7775.8 7787.1 7633.9 7696.3 7713.0 7733.8 7735.1 37261.4 37342.6 37477.3 37659.8 37730.4 3088.8 3119.7 3139.8 3169.4 3492.5 28664.6 28838.3 28922.0 29095.0 29498.0 3282.4 3294.6 3296.1 3345.9 3393.1 166698.0 168022.0 168327.0 168408.0 168439.0 31178.3 32259.7 54107.5 54192.5 54759.7 32712.8 33150.0 33336.0 33464.2 33573.5 13863.9 13929.5 13943.7 14030.4 14086.4 11573.9 11579.1 11596.3 11602.2 11608.9 7759.8 7809.2 7840.5 7874.1 7899.6 3036.8 3054.3 3071.1 3078.3 3090.2 825.4 915.3 921.5 924.8 990.5 27433.7 28036.4 28176.4 28550.9 28700.6 899.6 956.3 993.2 997.3 999.9 14447.7 14612.7 14701.9 14909.9 15160.0 367639.0 368340.0 369261.0 371821.0 372507.0 48957.3 49245.5 49274.8 49347.5 49548.8 1141.5 1182.6 1186.1 1189.1 1191.7 25746.7 26299.2 27117.6 27541.0 27597.8 37322.0 37445.8 37446.8 37480.3 37538.0 313088.0 313581.0 314430.0 314561.0 314991.0 25238.5 25491.0 25613.4 25637.6 25692.0 41567.8 42023.6 42265.0 42496.8 43033.1 35085.3 35727.6 35746.0 35893.6 35929.0 35828.5 36316.6 36346.8 36404.8 36449.3 34538.8 34749.8 35275.5 35569.8 35650.0 30739.7 32557.7 33151.0 33231.8 33401.2 24897.3 25274.4 25310.6 25704.2 25892.2 09:38:45 INFO - PROCESS | 26293 | 09:38:45 INFO - PROCESS | 26293 | [#2] jquery.html Cycles:180 Average:24778.01 Median:4524.40 stddev:66023.98 (1459.3%) stddev-sans-first:66183.74 09:38:45 INFO - PROCESS | 26293 | Values: 361.2 362.7 369.9 377.6 379.2 15855.9 16071.6 17035.3 17098.2 17134.8 14329.0 16292.8 16828.9 16844.3 16955.7 4856.9 5097.8 5105.5 5106.1 5106.8 4899.9 4939.7 4973.7 4980.7 4984.4 4976.5 5022.5 5028.5 5165.8 5179.3 5113.3 5143.9 5152.5 5162.7 5173.2 4345.4 4425.5 4443.4 4498.2 4501.4 14207.9 14356.0 19092.0 19349.2 19475.2 1873.4 1887.7 2057.0 2177.3 2280.8 13286.5 13398.5 13582.5 13613.9 13785.7 1731.5 1774.7 1799.3 1816.0 1825.4 66896.3 67788.0 67979.7 68560.7 69281.7 9445.9 9598.8 9740.7 9748.2 10032.9 13326.5 13333.2 13346.8 13354.2 13365.9 7254.8 7426.0 7459.2 7602.5 7708.9 7269.4 7330.1 7432.7 7491.5 7552.3 5887.4 5950.6 6017.4 6084.2 6169.0 1748.8 1758.6 1764.5 1809.1 1829.9 822.0 831.9 843.0 860.6 945.5 16719.0 16756.4 16841.9 17299.1 18102.5 837.8 843.3 847.1 915.8 943.3 9616.0 9806.6 9876.6 9946.2 10003.2 384215.0 400906.0 401983.0 402902.0 405325.0 81693.6 82417.6 83618.6 85251.0 85347.6 909.1 938.0 956.3 966.8 966.8 12293.5 14496.6 15285.0 15299.2 16068.0 37301.8 37333.8 37513.2 38489.8 40056.4 52606.7 52885.7 54083.6 54429.0 55686.4 7494.3 7775.3 7925.4 7996.0 8092.0 9969.0 11114.7 11223.0 11607.3 12594.2 10225.8 10378.7 10473.7 10562.3 10710.2 4547.4 6260.7 10459.6 10507.5 10593.0 10079.3 10113.2 10218.4 10604.8 10738.2 7672.5 7848.8 7958.2 7989.6 7997.2 9684.2 9775.4 9855.2 10264.2 10452.3 09:38:45 INFO - PROCESS | 26293 | 09:38:45 INFO - PROCESS | 26293 | [#3] mootools.html Cycles:180 Average:5172.45 Median:4754.49 stddev:2908.85 (61.2%) stddev-sans-first:2902.89 09:38:45 INFO - PROCESS | 26293 | Values: 1358.8 1385.8 1471.8 1629.9 1692.7 6861.7 7493.8 7645.1 8134.8 8152.3 7807.5 8039.1 8055.8 8064.2 8073.4 2206.1 2239.1 2253.1 2254.1 2260.3 2202.2 2234.2 2288.5 2291.4 2292.0 2240.3 2255.1 2264.3 2267.9 2273.9 2187.9 2198.8 2201.7 2202.1 2202.8 2200.5 2206.2 2206.5 2207.4 2218.5 7990.7 8056.0 8089.1 8090.6 8124.8 4589.0 4738.7 4740.8 4740.9 4743.8 2960.4 3025.1 3188.0 3192.1 3193.4 984.4 992.3 1001.8 1018.8 1022.0 10817.2 10964.2 10966.7 11002.2 11013.5 4228.3 4321.7 4461.2 4477.0 4533.4 8441.6 8446.7 8451.0 8507.3 8514.4 4691.3 4708.8 4724.2 4730.7 4738.6 3666.0 4128.5 4218.9 4416.3 4422.6 3512.2 3512.4 3590.7 3631.2 3747.4 1053.6 1084.9 1085.7 1093.3 1094.3 776.3 818.4 848.0 852.2 857.8 5177.9 5239.7 5240.7 5321.1 5409.5 421.4 423.1 427.0 427.3 429.2 3475.4 3572.1 3587.5 3633.5 3649.2 9306.2 9736.1 9760.1 9763.3 9807.1 9755.3 9803.1 9821.4 9824.5 9835.7 7261.4 7297.7 7372.8 7466.0 7474.3 5245.8 5312.9 5313.4 5328.8 5385.9 8868.7 8979.6 9011.8 9025.3 9037.0 8927.6 9156.2 9195.9 9201.9 9301.0 5591.2 6178.1 6349.8 6390.0 6494.8 7704.8 7777.8 7862.3 7892.2 7898.6 6727.6 6893.7 6897.2 6898.4 7077.5 6582.6 6608.6 6638.9 6657.7 6884.4 6002.6 6226.9 6285.6 6298.1 6314.1 4543.8 4547.0 4558.2 4621.5 4650.1 4548.7 4655.3 4714.7 4765.2 4937.2 09:38:45 INFO - PROCESS | 26293 | 09:38:45 INFO - PROCESS | 26293 | [#4] prototype.html Cycles:180 Average:4258.26 Median:4654.16 stddev:1238.72 (26.6%) stddev-sans-first:1206.00 09:38:45 INFO - PROCESS | 26293 | Values: 297.6 302.2 308.9 310.8 312.4 4868.2 4977.3 5052.4 5092.5 5117.6 4974.5 5026.0 5029.2 5031.7 5043.4 3951.0 3972.3 3974.1 3984.6 3988.2 3919.8 3925.6 3986.6 3990.2 3993.5 3932.5 3955.8 3966.2 3969.2 3970.5 3938.8 3968.4 3975.7 3982.3 3985.7 3466.8 3491.4 3499.5 3500.2 3504.4 4683.0 4973.0 4984.3 5024.5 5028.1 4462.8 4476.8 4479.3 4484.3 4486.8 5222.1 5245.6 5249.0 5263.3 5345.7 3596.6 3687.6 3697.5 3703.7 3716.9 5491.3 5497.8 5504.2 5533.5 5586.4 3832.4 3834.3 3839.4 3839.9 3848.7 3746.8 3891.2 3894.6 3898.9 3900.5 4364.1 4392.5 4393.8 4437.1 4442.8 5211.5 5245.9 5253.5 5256.2 5363.8 1265.7 1293.9 1317.1 1325.5 1333.1 866.2 873.7 902.6 905.1 909.8 4648.5 4648.7 4650.2 4657.3 4669.0 5447.5 5454.7 5462.0 5466.2 5476.4 4381.4 4651.0 4658.5 4660.3 4673.6 2491.7 2524.9 2545.8 2556.7 2565.9 4516.6 4544.7 4549.9 4552.7 4560.5 4665.8 4900.0 4902.6 4916.7 4935.8 4460.7 4500.3 4513.8 4537.0 4545.4 4788.0 4825.5 4831.5 4838.2 4844.0 4581.7 4724.1 4733.2 4738.6 4760.3 4532.8 4536.3 4543.5 4565.2 4598.7 3464.1 3466.5 3468.3 3481.5 3486.3 4816.7 4817.0 4840.2 4854.3 5265.6 5180.0 5323.7 5334.8 5335.6 5346.2 5324.0 5324.7 5332.5 5337.5 5343.3 5085.5 5235.8 5247.9 5261.8 5292.8 5351.3 5365.8 5368.8 5369.3 5386.8 5171.5 5230.8 5245.5 5266.8 5286.0 09:38:45 INFO - PROCESS | 26293 | 09:38:45 INFO - PROCESS | 26293 | [#5] yui.html Cycles:180 Average:17063.34 Median:28848.83 stddev:23969.39 (83.1%) stddev-sans-first:24004.88 09:38:45 INFO - PROCESS | 26293 | Values: 633.3 679.6 733.5 735.6 749.9 12637.4 12839.7 13053.5 13985.0 14002.4 13378.7 13647.6 13648.5 13658.2 13690.6 623.5 756.6 777.6 778.8 782.6 743.8 776.4 783.6 784.4 785.6 826.1 828.1 828.5 829.5 831.5 823.3 823.7 824.2 824.5 824.7 599.0 603.3 604.9 605.2 605.5 13275.4 13283.7 13283.8 13295.5 13379.5 13480.9 13515.7 13835.8 14043.9 14173.1 10655.3 10792.5 10863.2 10908.9 10941.9 3316.6 3346.6 3351.3 3406.3 3471.5 62281.0 63676.4 64023.0 64172.0 65383.3 10883.1 10948.2 10949.6 11071.0 11160.6 20664.3 20722.4 20818.4 20830.9 20869.0 6980.9 6990.2 7070.8 7121.3 7246.7 3540.7 3722.5 3754.2 3757.9 3834.0 2968.5 3070.9 3088.0 3090.8 3102.2 528.2 529.9 542.3 545.9 549.9 489.8 537.2 557.2 567.9 572.7 7583.8 7609.0 7847.8 7897.3 8133.6 461.4 495.6 553.4 580.7 581.5 3621.4 3786.9 3799.4 3862.1 3953.1 56427.0 56587.7 56978.4 57125.0 94138.0 83540.0 84138.0 86528.0 87279.6 88474.6 77508.0 78084.2 78562.6 80315.6 83935.6 6941.3 7497.4 7527.3 7625.7 7737.4 45345.3 45354.3 46127.5 46155.8 47504.0 64137.7 66247.7 66591.3 67817.0 68065.0 8949.3 8984.6 9568.6 9753.2 9772.5 10779.1 10950.6 11091.1 11342.6 11766.5 10393.6 10420.1 10523.4 10734.9 10773.9 10048.5 10212.2 10374.4 10529.5 10597.5 9566.5 9714.1 9715.5 9864.5 9929.7 8329.0 8482.8 8569.7 8634.5 8964.6 8470.5 8580.8 8956.5 9079.3 9128.3 09:38:45 INFO - PROCESS | 26293 | -------- Summary: end -------- 09:38:45 INFO - PROCESS | 26293 | 09:38:47 INFO - TEST-INFO | 26293: exit 0 09:38:47 INFO - TEST-OK | dromaeo_css | took 1118444ms 09:38:47 INFO - TEST-START | kraken 09:38:47 INFO - operating with platform_type : linux_ 09:38:47 INFO - Initialising browser for kraken test... 09:38:47 INFO - TEST-INFO | started process 26654 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaM4IZc/profile http://localhost:58488/getInfo.html) 09:38:51 INFO - PROCESS | 26654 | __metrics Screen width/height:1600/1200 09:38:51 INFO - PROCESS | 26654 | colorDepth:24 09:38:51 INFO - PROCESS | 26654 | Browser inner width/height: 1024/697 09:38:51 INFO - PROCESS | 26654 | __metrics 09:38:52 ERROR - PROCESS | 26654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 09:38:53 INFO - TEST-INFO | 26654: exit 0 09:38:53 INFO - Browser initialized. 09:38:53 INFO - Running cycle 1/1 for kraken test... 09:38:53 INFO - TEST-INFO | started process 26771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaM4IZc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:39:05 INFO - PROCESS | 26771 | RSS: Main: 193339392 09:39:05 INFO - PROCESS | 26771 | 09:39:08 INFO - PROCESS | 26771 | Cycle 1(1): loaded http://localhost:58488/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58488/tests/kraken/driver.html?testName=audio-beat-detection) 09:39:09 INFO - PROCESS | 26771 | RSS: Main: 205819904 09:39:09 INFO - PROCESS | 26771 | 09:39:12 INFO - PROCESS | 26771 | Cycle 1(1): loaded http://localhost:58488/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58488/tests/kraken/driver.html?testName=audio-dft) 09:39:12 INFO - PROCESS | 26771 | RSS: Main: 204791808 09:39:12 INFO - PROCESS | 26771 | 09:39:15 INFO - PROCESS | 26771 | Cycle 1(1): loaded http://localhost:58488/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58488/tests/kraken/driver.html?testName=audio-fft) 09:39:16 INFO - PROCESS | 26771 | RSS: Main: 197648384 09:39:16 INFO - PROCESS | 26771 | 09:39:18 INFO - PROCESS | 26771 | Cycle 1(1): loaded http://localhost:58488/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58488/tests/kraken/driver.html?testName=audio-oscillator) 09:39:19 INFO - PROCESS | 26771 | RSS: Main: 197488640 09:39:19 INFO - PROCESS | 26771 | 09:39:21 INFO - PROCESS | 26771 | Cycle 1(1): loaded http://localhost:58488/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58488/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:39:22 INFO - PROCESS | 26771 | RSS: Main: 197959680 09:39:22 INFO - PROCESS | 26771 | 09:39:25 INFO - PROCESS | 26771 | Cycle 1(1): loaded http://localhost:58488/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58488/tests/kraken/driver.html?testName=imaging-darkroom) 09:39:26 INFO - PROCESS | 26771 | RSS: Main: 198602752 09:39:26 INFO - PROCESS | 26771 | 09:39:29 INFO - PROCESS | 26771 | Cycle 1(1): loaded http://localhost:58488/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58488/tests/kraken/driver.html?testName=imaging-desaturate) 09:39:30 INFO - PROCESS | 26771 | RSS: Main: 194469888 09:39:30 INFO - PROCESS | 26771 | 09:39:33 INFO - PROCESS | 26771 | Cycle 1(1): loaded http://localhost:58488/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58488/tests/kraken/driver.html?testName=json-parse-financial) 09:39:33 INFO - PROCESS | 26771 | RSS: Main: 196280320 09:39:33 INFO - PROCESS | 26771 | 09:39:35 INFO - PROCESS | 26771 | Cycle 1(1): loaded http://localhost:58488/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58488/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:39:36 INFO - PROCESS | 26771 | RSS: Main: 196100096 09:39:36 INFO - PROCESS | 26771 | 09:39:38 INFO - PROCESS | 26771 | Cycle 1(1): loaded http://localhost:58488/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58488/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:39:38 INFO - PROCESS | 26771 | RSS: Main: 196673536 09:39:38 INFO - PROCESS | 26771 | 09:39:41 INFO - PROCESS | 26771 | Cycle 1(1): loaded http://localhost:58488/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58488/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:39:41 INFO - PROCESS | 26771 | RSS: Main: 197099520 09:39:41 INFO - PROCESS | 26771 | 09:39:44 INFO - PROCESS | 26771 | Cycle 1(1): loaded http://localhost:58488/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:39:45 INFO - PROCESS | 26771 | RSS: Main: 197865472 09:39:45 INFO - PROCESS | 26771 | 09:39:48 INFO - PROCESS | 26771 | Cycle 1(1): loaded http://localhost:58488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:39:48 INFO - PROCESS | 26771 | RSS: Main: 197419008 09:39:48 INFO - PROCESS | 26771 | 09:39:50 INFO - PROCESS | 26771 | Cycle 1(1): loaded http://localhost:58488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58488/tests/kraken/driver.html?testName=ai-astar) 09:39:50 INFO - PROCESS | 26771 | RSS: Main: 199856128 09:39:50 INFO - PROCESS | 26771 | 09:39:50 INFO - PROCESS | 26771 | __start_tp_report 09:39:50 INFO - PROCESS | 26771 | _x_x_mozilla_page_load 09:39:50 INFO - PROCESS | 26771 | _x_x_mozilla_page_load_details 09:39:50 INFO - PROCESS | 26771 | |i|pagename|runs| 09:39:50 INFO - PROCESS | 26771 | |0;ai-astar;111;116;119;116;115;116;114;114;120;134 09:39:50 INFO - PROCESS | 26771 | |1;audio-beat-detection;149;131;153;179;140;158;153;126;205;125 09:39:50 INFO - PROCESS | 26771 | |2;audio-dft;178;167;164;165;165;166;167;167;166;166 09:39:50 INFO - PROCESS | 26771 | |3;audio-fft;78;77;77;171;80;77;76;76;175;78 09:39:50 INFO - PROCESS | 26771 | |4;audio-oscillator;83;90;159;84;85;86;127;84;84;143 09:39:50 INFO - PROCESS | 26771 | |5;imaging-gaussian-blur;120;120;118;118;117;118;121;118;118;119 09:39:50 INFO - PROCESS | 26771 | |6;imaging-darkroom;148;149;148;148;150;150;150;150;149;149 09:39:50 INFO - PROCESS | 26771 | |7;imaging-desaturate;96;97;95;95;96;96;96;96;97;96 09:39:50 INFO - PROCESS | 26771 | |8;json-parse-financial;64;67;67;66;67;66;67;67;67;65 09:39:50 INFO - PROCESS | 26771 | |9;json-stringify-tinderbox;67;67;66;66;66;66;67;67;67;66 09:39:50 INFO - PROCESS | 26771 | |10;stanford-crypto-aes;86;90;84;84;82;83;99;87;90;82 09:39:50 INFO - PROCESS | 26771 | |11;stanford-crypto-ccm;139;144;150;136;148;138;138;138;171;148 09:39:50 INFO - PROCESS | 26771 | |12;stanford-crypto-pbkdf2;175;180;176;174;177;173;180;180;174;182 09:39:50 INFO - PROCESS | 26771 | |13;stanford-crypto-sha256-iterative;71;70;73;70;69;70;72;71;70;72 09:39:50 INFO - PROCESS | 26771 | __end_tp_report 09:39:50 INFO - PROCESS | 26771 | __start_cc_report 09:39:50 INFO - PROCESS | 26771 | _x_x_mozilla_cycle_collect,884 09:39:50 INFO - PROCESS | 26771 | __end_cc_report 09:39:50 INFO - PROCESS | 26771 | __startTimestamp1472661590947__endTimestamp 09:39:50 INFO - PROCESS | 26771 | 09:39:50 INFO - PROCESS | 26771 | ------- Summary: start ------- 09:39:50 INFO - PROCESS | 26771 | Number of tests: 14 09:39:50 INFO - PROCESS | 26771 | 09:39:50 INFO - PROCESS | 26771 | [#0] ai-astar Cycles:10 Average:117.50 Median:116.00 stddev:6.33 (5.5%) stddev-sans-first:6.26 09:39:50 INFO - PROCESS | 26771 | Values: 111.0 116.0 119.0 116.0 115.0 116.0 114.0 114.0 120.0 134.0 09:39:50 INFO - PROCESS | 26771 | 09:39:50 INFO - PROCESS | 26771 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:153.00 stddev:24.89 (16.3%) stddev-sans-first:26.38 09:39:50 INFO - PROCESS | 26771 | Values: 149.0 131.0 153.0 179.0 140.0 158.0 153.0 126.0 205.0 125.0 09:39:50 INFO - PROCESS | 26771 | 09:39:50 INFO - PROCESS | 26771 | [#2] audio-dft Cycles:10 Average:167.10 Median:166.50 stddev:3.96 (2.4%) stddev-sans-first:1.05 09:39:50 INFO - PROCESS | 26771 | Values: 178.0 167.0 164.0 165.0 165.0 166.0 167.0 167.0 166.0 166.0 09:39:50 INFO - PROCESS | 26771 | 09:39:50 INFO - PROCESS | 26771 | [#3] audio-fft Cycles:10 Average:96.50 Median:77.00 stddev:40.35 (52.4%) stddev-sans-first:42.23 09:39:50 INFO - PROCESS | 26771 | Values: 78.0 77.0 77.0 171.0 80.0 77.0 76.0 76.0 175.0 78.0 09:39:50 INFO - PROCESS | 26771 | 09:39:50 INFO - PROCESS | 26771 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:84.00 stddev:29.01 (34.5%) stddev-sans-first:29.90 09:39:50 INFO - PROCESS | 26771 | Values: 83.0 90.0 159.0 84.0 85.0 86.0 127.0 84.0 84.0 143.0 09:39:50 INFO - PROCESS | 26771 | 09:39:50 INFO - PROCESS | 26771 | [#5] imaging-gaussian-blur Cycles:10 Average:118.70 Median:118.50 stddev:1.25 (1.1%) stddev-sans-first:1.24 09:39:50 INFO - PROCESS | 26771 | Values: 120.0 120.0 118.0 118.0 117.0 118.0 121.0 118.0 118.0 119.0 09:39:50 INFO - PROCESS | 26771 | 09:39:50 INFO - PROCESS | 26771 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.50 stddev:0.88 (0.6%) stddev-sans-first:0.83 09:39:50 INFO - PROCESS | 26771 | Values: 148.0 149.0 148.0 148.0 150.0 150.0 150.0 150.0 149.0 149.0 09:39:50 INFO - PROCESS | 26771 | 09:39:50 INFO - PROCESS | 26771 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 09:39:50 INFO - PROCESS | 26771 | Values: 96.0 97.0 95.0 95.0 96.0 96.0 96.0 96.0 97.0 96.0 09:39:50 INFO - PROCESS | 26771 | 09:39:50 INFO - PROCESS | 26771 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:67.00 stddev:1.06 (1.6%) stddev-sans-first:0.73 09:39:50 INFO - PROCESS | 26771 | Values: 64.0 67.0 67.0 66.0 67.0 66.0 67.0 67.0 67.0 65.0 09:39:50 INFO - PROCESS | 26771 | 09:39:50 INFO - PROCESS | 26771 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 09:39:50 INFO - PROCESS | 26771 | Values: 67.0 67.0 66.0 66.0 66.0 66.0 67.0 67.0 67.0 66.0 09:39:50 INFO - PROCESS | 26771 | 09:39:50 INFO - PROCESS | 26771 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:86.50 stddev:5.23 (6.0%) stddev-sans-first:5.54 09:39:50 INFO - PROCESS | 26771 | Values: 86.0 90.0 84.0 84.0 82.0 83.0 99.0 87.0 90.0 82.0 09:39:50 INFO - PROCESS | 26771 | 09:39:50 INFO - PROCESS | 26771 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:146.00 stddev:10.46 (7.2%) stddev-sans-first:10.86 09:39:50 INFO - PROCESS | 26771 | Values: 139.0 144.0 150.0 136.0 148.0 138.0 138.0 138.0 171.0 148.0 09:39:50 INFO - PROCESS | 26771 | 09:39:50 INFO - PROCESS | 26771 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.10 Median:178.50 stddev:3.18 (1.8%) stddev-sans-first:3.28 09:39:50 INFO - PROCESS | 26771 | Values: 175.0 180.0 176.0 174.0 177.0 173.0 180.0 180.0 174.0 182.0 09:39:50 INFO - PROCESS | 26771 | 09:39:50 INFO - PROCESS | 26771 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:1.23 (1.7%) stddev-sans-first:1.30 09:39:50 INFO - PROCESS | 26771 | Values: 71.0 70.0 73.0 70.0 69.0 70.0 72.0 71.0 70.0 72.0 09:39:50 INFO - PROCESS | 26771 | -------- Summary: end -------- 09:39:50 INFO - PROCESS | 26771 | 09:39:52 INFO - TEST-INFO | 26771: exit 0 09:39:52 INFO - TEST-OK | kraken | took 65123ms 09:39:52 INFO - SUITE-END | took 1183s 09:39:52 INFO - Completed test suite (00:19:43) 09:39:52 INFO - javascript benchmark 09:39:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6322.769160936143, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2635.367511797169, 2662.32110811743, 2674.9866250668742, 2675.1172113202633, 2682.7049024607277, 4755.381800365947, 4829.37218161639, 4856.174450343441, 4889.7555122243875, 4972.378452693413, 4755.048990201964, 4773.594244489213, 4837.612990960714, 4870.099031679142, 4875.268709693548, 4398.912021759563, 4472.463304403476, 4473.7986790594505, 4577.542245775412, 4588.0, 4495.752733599651, 4511.345854851061, 4568.725876447407, 4587.816487340502, 4594.65540084495, 4290.399344091829, 4329.069250111241, 4391.494978077498, 4408.515063343029, 4455.108978204372, 4349.847755328548, 4363.716358436692, 4392.626626736731, 4463.642908567307, 4481.865544033684, 4399.1641588098155, 4402.51572327047, 4409.074094440171, 4415.66882483815, 4484.8878778030485, 4722.480527142012, 4797.880052998668, 4804.23132298834, 4823.589994850442, 4828.927566086476, 5139.383274007143, 5152.871178220575, 5157.432682404932, 5157.767900444452, 5227.634065615409, 5113.360829896263, 5140.948590514085, 5181.145111056671, 5181.792728290864, 5183.688978661255, 4723.031778485437, 4760.262159365304, 4760.500147484534, 4793.18515852306, 4822.228443449031, 5288.2596436498925, 5304.496072873071, 5313.814016509404, 5328.280682107943, 5337.412884582693, 5070.036693028386, 5102.617303702237, 5111.514406131411, 5118.10433174193, 5174.7153906535505, 5030.547250747377, 5069.670471419346, 5201.947980520146, 5211.42674305826, 5219.817306394258, 5159.742012899415, 5159.7678104485385, 5174.068667639785, 5191.0, 5214.7914083436235, 5120.462351453044, 5120.897582048413, 5135.87160320995, 5137.101007323703, 5193.091209038479, 4301.698881078294, 4370.912581748347, 4390.714603550823, 4393.011572396249, 4417.491988421309, 3811.866584669523, 3814.1799513104816, 3828.75113117652, 3849.4995650565247, 3860.942085868714, 4432.224360736858, 4432.534583868712, 4438.755868427267, 4445.977770111193, 4469.843555475542, 5061.392632884077, 5148.871278218, 5176.792928282902, 5220.660657057279, 5234.581233501311, 4439.289713645801, 4465.173942820588, 4471.038726673716, 4509.368688383629, 4523.389342438729, 4693.718376897397, 4697.95302046982, 4707.270373092176, 4714.81140754366, 4761.714297142183, 4685.742284174403, 4758.262469317261, 4774.689645173053, 4827.565519103297, 4871.780769865435, 5124.180131178993, 5138.306328645585, 5150.665206761549, 5152.819651312186, 5201.557867581298, 4803.255495398219, 4803.351547541037, 4806.2310030394965, 4815.662903596714, 4852.75736213195, 4958.776855041459, 5088.338515992898, 5164.7417629119145, 5179.067767801681, 5233.293505376878, 5191.0, 5197.974010129925, 5211.973940130275, 5216.061109000417, 5251.186066159751, 5092.6435149539175, 5097.235414687826, 5098.133317336136, 5098.643094983316, 5171.45699701541, 4871.488493708252, 4961.677490963076, 4965.4041515018425, 4966.379202599675, 5037.949620503895, 4862.222044472867, 4874.780634871368, 4959.305697202467, 4960.553550180501, 5011.373578302712, 5065.518775716301, 5078.136716758234, 5084.593232541314, 5085.186370180753, 5097.490250974873, 4854.126257273583, 4954.826581069645, 5002.324686167321, 5007.29897814299, 5012.0], "value": 4741.917860863319, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.619382625988, 551.6689986008395, 558.8602849287678, 563.3633993587246, 587.8412828536298, 34859.30281394371, 38793.41809872854, 38873.61126388735, 38977.025574360654, 39057.414138787906, 38936.22127557447, 39101.21797564054, 39506.40740388897, 39614.0, 39676.20647587054, 7670.731524396633, 7805.687772489122, 7822.061352637691, 7825.060992680857, 7829.334506566948, 7638.465307428482, 7726.150123486412, 7727.8068048298965, 7729.34300584451, 7733.574653394061, 7662.6934922603305, 7725.18885517021, 7730.149683534834, 7781.3385862201785, 7786.26030527099, 7694.384449244103, 7704.730334438268, 7709.922900770976, 7775.766726998199, 7787.06555213378, 7633.923660763432, 7696.268854458817, 7712.9614351927885, 7733.7679869604, 7735.071791385014, 37261.44107838358, 37342.62657373419, 37477.250454990746, 37659.81170094132, 37730.43404348937, 3088.8146711197173, 3119.7192252697364, 3139.764517661162, 3169.4453470642775, 3492.528508651325, 28664.570031449544, 28838.279043023882, 28922.0, 29095.0, 29498.0, 3282.3763484937786, 3294.58817647794, 3296.1430028192844, 3345.9498107528407, 3393.100828280508, 166698.0, 168022.0, 168326.99999999878, 168408.0, 168439.0, 31178.258608966615, 32259.67740322614, 54107.45892541103, 54192.45807541953, 54759.726201368736, 32712.83643581767, 33150.0, 33336.0, 33464.16339591481, 33573.49639755406, 13863.861361386256, 13929.512467063603, 13943.651408714863, 14030.438782448791, 14086.436542538184, 11573.942130289295, 11579.073674106052, 11596.304221746723, 11602.18784685064, 11608.941955290169, 7759.844803103906, 7809.2190780921455, 7840.490368126054, 7874.133845277015, 7899.605019748989, 3036.8481575921114, 3054.2517083314287, 3071.1400807773857, 3078.291992841659, 3090.1656552731088, 825.3644693585906, 915.272358475014, 921.4931787516839, 924.8300899362312, 990.5047476261869, 27433.725662743516, 28036.43927121446, 28176.43647127046, 28550.857245714054, 28700.569491457645, 899.5996781432331, 956.3114557518576, 993.2054356514759, 997.3244948486612, 999.9100080992746, 14447.711045779026, 14612.707745845024, 14701.926490367694, 14909.850901491063, 15160.0, 367639.0, 368340.0, 369261.0, 371821.0, 372507.0, 48957.265641015416, 49245.50754492481, 49274.75362623164, 49347.50652493501, 49548.75225623849, 1141.4920360439526, 1182.5565412970136, 1186.1341220908612, 1189.0665827325681, 1191.7259030423052, 25746.742532575183, 26299.21102366932, 27117.593236101868, 27541.0, 27597.75810088511, 37322.0, 37445.81277093706, 37446.812765935996, 37480.250394992494, 37538.0, 313088.0, 313581.0, 314430.0, 314561.0, 314991.0, 25238.49523009566, 25491.0, 25613.359666007753, 25637.615435768104, 25692.0, 41567.792161039004, 42023.57976420197, 42265.0, 42496.78751606222, 43033.13933721371, 35085.29829403449, 35727.64272357243, 35746.0, 35893.64106358903, 35929.0, 35828.462573060904, 36316.636833631324, 36346.8182659085, 36404.81797591101, 36449.27101458009, 34538.82730586331, 34749.82625086858, 35275.470867936485, 35569.82215088908, 35650.0, 30739.692603073683, 32557.674423255463, 33151.0, 33231.833840830644, 33401.16497087592, 24897.25308240756, 25274.36814079663, 25310.620340694535, 25704.228873133838, 25892.22323330303], "value": 16089.9975626525, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.1783193235389, 362.711644242827, 369.87054530914185, 377.58465687743467, 379.16394350457244, 15855.920720396396, 16071.598210044755, 17035.318587256494, 17098.230579623916, 17134.82865171348, 14329.0, 16292.755608665879, 16828.915855420735, 16844.32622695094, 16955.660886782258, 4856.927146092811, 5097.770600322994, 5105.540501354877, 5106.055379754739, 5106.846794596168, 4899.8775030624165, 4939.67892087015, 4973.651844370896, 4980.651354405193, 4984.4018717753925, 4976.4774698656665, 5022.522860328263, 5028.49715028496, 5165.81919632813, 5179.326687530615, 5113.284140220372, 5143.922841157386, 5152.458991805844, 5162.6902385856965, 5173.249878767595, 4345.435093437864, 4425.491068527129, 4443.4445694288215, 4498.167838949772, 4501.369808226851, 14207.85792142086, 14356.0, 19092.0, 19349.226030958886, 19475.220991160335, 1873.3911478769455, 1887.7168424736262, 2057.0, 2177.3250292409402, 2280.7719228077226, 13286.53497127596, 13398.464061437531, 13582.456701731919, 13613.931930340284, 13785.655358616015, 1731.5151757507917, 1774.6716857381296, 1799.3072667023291, 1816.0465755478479, 1825.3611236067402, 66896.3310366895, 67788.0, 67979.66010169918, 68560.6571967137, 69281.65359173172, 9445.90554094464, 9598.808023839623, 9740.707778766648, 9748.220142388735, 10032.899671003197, 13326.533571324957, 13333.20000799955, 13346.799798003038, 13354.198748075147, 13365.866341336656, 7254.818629534304, 7426.0, 7459.216782237895, 7602.46782725204, 7708.884366734504, 7269.382102521345, 7330.083739532559, 7432.702691892372, 7491.513051651626, 7552.320291173821, 5887.381824908409, 5950.642961422329, 6017.398260173947, 6084.202061410807, 6169.0259117082105, 1748.833860783249, 1758.5691505581215, 1764.461839139075, 1809.1044932758368, 1829.9268029278946, 821.9876701849477, 831.9251267385844, 842.9662813487514, 860.5740158621522, 945.5272363818091, 16719.0, 16756.413525526546, 16841.915790420968, 17299.13504324779, 18102.45692629223, 837.8240569480478, 843.2832092721261, 847.0978407995465, 915.8259930613162, 943.3113826906397, 9616.0, 9806.607735690492, 9876.604935802487, 9946.154576860903, 10003.199744020461, 384215.0, 400906.0, 401983.0, 402902.0, 405325.0, 81693.59153204196, 82417.58791206006, 83618.5819070913, 85251.0, 85347.57326213329, 909.1226965977995, 937.9822892161944, 956.2923436656824, 966.7534778631403, 966.8356379415376, 12293.508259669514, 14496.565103046925, 15285.0, 15299.235038248265, 16068.0, 37301.81349093237, 37333.81333093426, 37513.2497350046, 38489.80755096207, 40056.3991540133, 52606.73696631492, 52885.7355713219, 54083.647908802595, 54429.0, 55686.44313556812, 7494.250574942462, 7775.339096176662, 7925.445218834626, 7996.0, 8092.048669640205, 9969.0, 11114.666560003212, 11222.979863624625, 11607.30356178632, 12594.181378210387, 10225.795484090426, 10378.740531486774, 10473.68578942633, 10562.260641755003, 10710.196735244732, 4547.431571053618, 6260.655663938527, 10459.58161673555, 10507.527161277914, 10593.0, 10079.294449388766, 10113.24150688716, 10218.437985910548, 10604.840927385942, 10738.248322617654, 7672.462927595015, 7848.7645370638975, 7958.164392738679, 7989.600519974094, 7997.160298168841, 9684.176844967975, 9775.364601300893, 9855.21158307348, 10264.230182736175, 10452.32059916103], "value": 8263.27879224364, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.796180572914, 1385.8198434203553, 1471.7939488471616, 1629.9266533006014, 1692.6699293637746, 6861.725530978755, 7493.775186744399, 7645.082590089197, 8134.837303253938, 8152.307053900418, 7807.453478256524, 8039.075506316775, 8055.798605034877, 8064.193580641948, 8073.354131669467, 2206.117552978805, 2239.104358256702, 2253.0537174386795, 2254.0532976149975, 2260.3445000949705, 2202.174184680745, 2234.218023691711, 2288.5079707862806, 2291.3698732848434, 2292.0373443153917, 2240.271911628719, 2255.052877791323, 2264.320703788865, 2267.8639281643154, 2273.863568185906, 2187.8687278763327, 2198.8021078102965, 2201.7137772089527, 2202.0861342542826, 2202.812760915324, 2200.5378870437225, 2206.1837120265604, 2206.5366273082514, 2207.415035015722, 2218.456478162844, 7990.720324788605, 8055.959720201361, 8089.069756977964, 8090.635921383552, 8124.796880077986, 4589.0, 4738.691985020962, 4740.786664600101, 4740.881477963044, 4743.810247590092, 2960.422717570075, 3025.1378357168323, 3187.984060079708, 3192.058342788883, 3193.3613277344393, 984.3798407003542, 992.3103443107043, 1001.8447140693131, 1018.801333739921, 1022.0443884967505, 10817.242793004492, 10964.17768667353, 10966.725831854268, 11002.174836887265, 11013.504392302366, 4228.323468245066, 4321.7406955582765, 4461.196984542748, 4476.977615111904, 4533.370645025943, 8441.57792110392, 8446.66213351459, 8450.957745211235, 8507.319414446829, 8514.361422893184, 4691.272852707836, 4708.764561771898, 4724.244120940702, 4730.692504987165, 4738.573528382462, 3666.0, 4128.525219599785, 4218.915621687549, 4416.271315233015, 4422.557744225552, 3512.2448673535314, 3512.350215210194, 3590.6588874056924, 3631.1648320886343, 3747.4378843173195, 1053.5575058475306, 1084.902358787697, 1085.7394225385851, 1093.327603523827, 1094.2668412163869, 776.3168411797695, 818.4393690322148, 847.9993607543036, 852.1733918099434, 857.8027053777666, 5177.909710323919, 5239.711815850089, 5240.732425285591, 5321.068812957717, 5409.5131438169965, 421.43317238314415, 423.0629156418548, 427.04981416348375, 427.2906974422444, 429.15884865663025, 3475.42655461851, 3572.1248294168095, 3587.4798154268005, 3633.509476220729, 3649.1606930406156, 9306.162445379812, 9736.075072868067, 9760.121589057018, 9763.267754918268, 9807.117359437685, 9755.317127801127, 9803.068708472683, 9821.410715356958, 9824.508774561386, 9835.655752048644, 7261.38278246355, 7297.744578939818, 7372.778816635509, 7465.962670186615, 7474.3273105419685, 5245.763940622757, 5312.867178320573, 5313.362396512443, 5328.760205790826, 5385.946140538701, 8868.733937981871, 8979.55102244872, 9011.774705632411, 9025.277977761894, 9037.0, 8927.598258078273, 9156.175944165057, 9195.850518685163, 9201.907980920372, 9300.953495232481, 5591.21722958778, 6178.104174894705, 6349.809505714836, 6390.0, 6494.805155845333, 7704.8459030820195, 7777.766666999999, 7862.253085956825, 7892.210778922062, 7898.644560994654, 6727.629980351127, 6893.655317234218, 6897.172339319314, 6898.379145876896, 7077.469189810888, 6582.572132811352, 6608.636524991171, 6638.933610664025, 6657.700403481952, 6884.449244060363, 6002.579819412774, 6226.937730622817, 6285.59143655661, 6298.118263443213, 6314.147590075281, 4543.750093744876, 4547.045120524727, 4558.247889098262, 4621.514740952286, 4650.116477869194, 4548.681592288508, 4655.2784318430695, 4714.717116972993, 4765.166095933128, 4937.23472861707], "value": 4103.549401192204, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.5848691075949, 302.20670739309315, 308.85483822603373, 310.821277765285, 312.375249500998, 4868.17443458703, 4977.278294647274, 5052.39371275447, 5092.465291144432, 5117.641765076446, 4974.527419895104, 5026.0, 5029.170186919163, 5031.723255220962, 5043.445221025684, 3950.980245098785, 3972.3247048001763, 3974.132157885789, 3984.561698213194, 3988.202359528106, 3919.764814111148, 3925.6466917977377, 3986.6013398660193, 3990.221906728175, 3993.5207775067033, 3932.488776459071, 3955.782431966241, 3966.1869316790135, 3969.2260009298197, 3970.50368703912, 3938.7636741795586, 3968.444417781513, 3975.6819454443576, 3982.323005089156, 3985.681145508381, 3466.7746596471147, 3491.4064609016527, 3499.492573576817, 3500.2299494111253, 3504.4217704078796, 4683.0, 4972.950270497285, 4984.3021976923255, 5024.497550244982, 5028.069807085664, 4462.754548499831, 4476.84331048415, 4479.3057076153245, 4484.282514797616, 4486.820527178909, 5222.127829693653, 5245.554127899133, 5248.973755131238, 5263.26314315996, 5345.679259244458, 3596.5504311961004, 3687.5943646199166, 3697.500837386945, 3703.7222208334483, 3716.888493345204, 5491.258680078218, 5497.780088796443, 5504.2294078829, 5533.529649979757, 5586.374404030099, 3832.4442955771256, 3834.309824231609, 3839.424086387064, 3839.9040023999064, 3848.7113466490127, 3746.831392587286, 3891.221755648825, 3894.5521265054313, 3898.863539776094, 3900.4929359183125, 4364.127174565099, 4392.494863090786, 4393.780310984438, 4437.092050418351, 4442.800073996613, 5211.478852114834, 5245.868853278698, 5253.50091741284, 5256.185291279781, 5363.839084827461, 1265.6835791052238, 1293.8835504804613, 1317.124112465219, 1325.4830616059744, 1333.1068184316532, 866.2117473099449, 873.6854732296368, 902.6028547439106, 905.1401168889581, 909.8271328447573, 4648.5119062498625, 4648.721076735339, 4650.209464390994, 4657.347971284023, 4669.0, 5447.509724124848, 5454.672719636835, 5461.972690136524, 5466.234727138204, 5476.370217424967, 4381.364702118175, 4650.9767451162525, 4658.510856360033, 4660.324252983299, 4673.626109911199, 2491.6885389326335, 2524.911628093008, 2545.790749394023, 2556.6548515950108, 2565.871706414709, 4516.645006498037, 4544.7045942013665, 4549.863504094882, 4552.658550608718, 4560.4527456704745, 4665.766711664403, 4900.0, 4902.607791376681, 4916.72957987307, 4935.777889994959, 4460.687751857404, 4500.257457519473, 4513.842015529441, 4536.977315113403, 4545.3863728396245, 4787.95212047889, 4825.490744812608, 4831.492693267156, 4838.177509823409, 4843.975780121077, 4581.679282450196, 4724.149653062482, 4733.242681170997, 4738.649484896788, 4760.2625041860165, 4532.776150439428, 4536.319552067216, 4543.522930092425, 4565.223911935045, 4598.724076555283, 3464.116650254169, 3466.497357883143, 3468.289000754789, 3481.47777833327, 3486.302739452069, 4816.675414261106, 4817.0, 4840.201366774443, 4854.296127061486, 5265.631405801557, 5179.974100129475, 5323.707196104251, 5334.75993580282, 5335.573154147736, 5346.1713434417725, 5324.0, 5324.707141107121, 5332.493413125747, 5337.466253374631, 5343.251944727819, 5085.4914508548845, 5235.842924712265, 5247.921281180862, 5261.815836445706, 5292.814751483679, 5351.331083614548, 5365.812196573102, 5368.812091576776, 5369.27514785499, 5386.811461598825, 5171.456997015259, 5230.843074707765, 5245.527902488794, 5266.789328426973, 5285.973570132125], "value": 3866.021489445297, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.2907143998721, 679.6397909108174, 733.5195446982228, 735.6174789109659, 749.8687729647314, 12637.368131593417, 12839.679008024805, 13053.477860885554, 13985.0, 14002.369893354798, 13378.73242535151, 13647.590572282823, 13648.454061837514, 13658.248796316198, 13690.589282321522, 623.4638211138417, 756.648158606248, 777.6383981448625, 778.7663700889739, 782.5695867273006, 743.8252010777463, 776.3711393771064, 783.6121120045585, 784.3725019984018, 785.6071964017991, 826.0830478169257, 828.1221904780951, 828.4739190613943, 829.5354601423222, 831.5177197225595, 823.275517544563, 823.7446391618618, 824.171707434031, 824.5464994253197, 824.7484517222244, 599.0385431382612, 603.2881200183781, 604.9425304596057, 605.2041565341606, 605.5367643752533, 13275.402606882617, 13283.734325313537, 13283.800742988862, 13295.53465628708, 13379.531716389976, 13480.865191348059, 13515.66210844727, 13835.79246311306, 14043.859561404357, 14173.149611023371, 10655.30740501865, 10792.51433685486, 10863.18526110545, 10908.890911090946, 10941.945290273497, 3316.6185888622636, 3346.598408191033, 3351.2962277921665, 3406.267652454734, 3471.4966329882277, 62281.0, 63676.363236367506, 64023.0, 64172.0, 65383.3461665382, 10883.052991146515, 10948.233623646269, 10949.562017519369, 11071.0, 11160.609378671708, 20664.276750313667, 20722.378328650164, 20818.375448736562, 20830.895845520674, 20869.0, 6980.895286570705, 6990.196127445307, 7070.787876363717, 7121.323474269936, 7246.673899674527, 3540.6990405815277, 3722.4602432647657, 3754.249150169977, 3757.9248415031548, 3834.0, 2968.4805159097073, 3070.9078727638207, 3088.0, 3090.799098058619, 3102.1624161476275, 528.2498851630617, 529.933758280215, 542.2977244468423, 545.9344878614592, 549.9340079190442, 489.79918233524086, 537.2156651289083, 557.2059814763945, 567.9379560222411, 572.6592677356966, 7583.848323033509, 7609.0, 7847.803804904809, 7897.3287270581495, 8133.589802366064, 461.4278294914349, 495.56142813610217, 553.4493179286635, 580.6516090345843, 581.5347721822525, 3621.3662609043313, 3786.905327366783, 3799.35410980134, 3862.1310205204168, 3953.1105501261986, 56427.0, 56587.71706141443, 56978.43021569814, 57125.0, 94138.0, 83540.0, 84138.0, 86528.0, 87279.56360218159, 88474.55762721146, 77508.0, 78084.21915780882, 78562.60718696484, 80315.59842200752, 83935.580322098, 6941.305869413019, 7497.362724168507, 7527.322540971339, 7625.6949722010495, 7737.419693522896, 45345.319820202065, 45354.319685204086, 46127.53872461232, 46155.76922115368, 47503.99999999862, 64137.67931160314, 66247.66876165588, 66591.33408665852, 67817.0, 68065.0, 8949.32880033987, 8984.640614375614, 9568.569414376509, 9753.170980466455, 9772.511374431393, 10779.13766898662, 10950.56197752081, 11091.112710983263, 11342.60300889465, 11766.529338826693, 10393.584256629953, 10420.06219440254, 10523.421211833116, 10734.892651073389, 10773.946130269298, 10048.497575121068, 10212.234082443994, 10374.429406382722, 10529.526171322155, 10597.523111459848, 9566.520165846106, 9714.077162669535, 9715.465649389069, 9864.506774661095, 9929.65246216379, 8329.042160151417, 8482.830343392974, 8569.657213711382, 8634.525101119247, 8964.596593153454, 8470.5106293662, 8580.785480363042, 8956.476140534714, 9079.273658107468, 9128.315376346667], "value": 6387.228548971593, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1611.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 119.0, 116.0, 115.0, 116.0, 114.0, 114.0, 120.0, 134.0], "value": 117.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 131.0, 153.0, 179.0, 140.0, 158.0, 153.0, 126.0, 205.0, 125.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 167.0, 164.0, 165.0, 165.0, 166.0, 167.0, 167.0, 166.0, 166.0], "value": 167.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 171.0, 80.0, 77.0, 76.0, 76.0, 175.0, 78.0], "value": 96.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 90.0, 159.0, 84.0, 85.0, 86.0, 127.0, 84.0, 84.0, 143.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 120.0, 118.0, 118.0, 117.0, 118.0, 121.0, 118.0, 118.0, 119.0], "value": 118.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 148.0, 150.0, 150.0, 150.0, 150.0, 149.0, 149.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 67.0, 66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 65.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 67.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 84.0, 84.0, 82.0, 83.0, 99.0, 87.0, 90.0, 82.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 144.0, 150.0, 136.0, 148.0, 138.0, 138.0, 138.0, 171.0, 148.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 180.0, 176.0, 174.0, 177.0, 173.0, 180.0, 180.0, 174.0, 182.0], "value": 177.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 73.0, 70.0, 69.0, 70.0, 72.0, 71.0, 70.0, 72.0], "value": 70.8, "unit": "score"}]}]} 09:39:52 INFO - Return code: 0 09:39:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:39:52 ERROR - # TBPL SUCCESS # 09:39:52 INFO - Running post-action listener: _resource_record_post_action 09:39:52 INFO - [mozharness: 2016-08-31 16:39:52.728100Z] Finished run-tests step (success) 09:39:52 INFO - Running post-run listener: _resource_record_post_run 09:39:52 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407334912; Read time: 8; Write time: 257780 09:39:52 INFO - TinderboxPrint: CPU usage
13.4% 09:39:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 09:39:52 INFO - TinderboxPrint: I/O write bytes / time
407,334,912 / 257,780 09:39:52 INFO - TinderboxPrint: CPU idle
8,280.5 (86.5%) 09:39:52 INFO - TinderboxPrint: CPU user
1,228.1 (12.8%) 09:39:52 INFO - TinderboxPrint: Swap in / out
0 / 0 09:39:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114282496; Read time: 0; Write time: 99912 09:39:52 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293052416; Read time: 8; Write time: 157868 09:39:53 INFO - Running post-run listener: _upload_blobber_files 09:39:53 INFO - Blob upload gear active. 09:39:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:39:53 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 09:39:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:39:53 INFO - (blobuploader) - INFO - Open directory for files ... 09:39:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:39:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:39:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:54 INFO - (blobuploader) - INFO - Done attempting. 09:39:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:39:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:39:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:58 INFO - (blobuploader) - INFO - Done attempting. 09:39:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:39:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:39:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:59 INFO - (blobuploader) - INFO - Done attempting. 09:39:59 INFO - (blobuploader) - INFO - Iteration through files over. 09:39:59 INFO - Return code: 0 09:39:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:39:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:39:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/767f799305c4d2191a3a51c094d5c491cf0bba3a3ce7c1be66b9e6d824bc80562d003adc7f61e498030aeb668f4e16230affedc6064dfa7d1ac1d8fdcc8d1086", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7288968e468f1d210856ba2484d0439c7942f7714911689fc0d080cc0f1d2b2c894bfabd904f92db6afbfbb24769941a951e0cd0e4021878b9fb705685d58e3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5adaaf500f3432771f3f0d6506485368b2061a00219f75bab1de822dc9c287126853601bf3bb182f88550809fe450fc57bec42c4a39b616228d9d208f27a6f74"} 09:39:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:39:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:39:59 INFO - Contents: 09:39:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/767f799305c4d2191a3a51c094d5c491cf0bba3a3ce7c1be66b9e6d824bc80562d003adc7f61e498030aeb668f4e16230affedc6064dfa7d1ac1d8fdcc8d1086", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7288968e468f1d210856ba2484d0439c7942f7714911689fc0d080cc0f1d2b2c894bfabd904f92db6afbfbb24769941a951e0cd0e4021878b9fb705685d58e3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5adaaf500f3432771f3f0d6506485368b2061a00219f75bab1de822dc9c287126853601bf3bb182f88550809fe450fc57bec42c4a39b616228d9d208f27a6f74"} 09:39:59 INFO - Running post-run listener: copy_logs_to_upload_dir 09:39:59 INFO - Copying logs to upload dir... 09:39:59 INFO - mkdir: /builds/slave/test/build/upload/logs 09:39:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.234408 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-31 09:39:57.687133) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 09:39:57.693073) ========= 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=6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/767f799305c4d2191a3a51c094d5c491cf0bba3a3ce7c1be66b9e6d824bc80562d003adc7f61e498030aeb668f4e16230affedc6064dfa7d1ac1d8fdcc8d1086", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7288968e468f1d210856ba2484d0439c7942f7714911689fc0d080cc0f1d2b2c894bfabd904f92db6afbfbb24769941a951e0cd0e4021878b9fb705685d58e3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5adaaf500f3432771f3f0d6506485368b2061a00219f75bab1de822dc9c287126853601bf3bb182f88550809fe450fc57bec42c4a39b616228d9d208f27a6f74"} build_url:https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011381 build_url: 'https://queue.taskcluster.net/v1/task/bSwix0wbT3GY6w0XXWnYSQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/767f799305c4d2191a3a51c094d5c491cf0bba3a3ce7c1be66b9e6d824bc80562d003adc7f61e498030aeb668f4e16230affedc6064dfa7d1ac1d8fdcc8d1086", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7288968e468f1d210856ba2484d0439c7942f7714911689fc0d080cc0f1d2b2c894bfabd904f92db6afbfbb24769941a951e0cd0e4021878b9fb705685d58e3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5adaaf500f3432771f3f0d6506485368b2061a00219f75bab1de822dc9c287126853601bf3bb182f88550809fe450fc57bec42c4a39b616228d9d208f27a6f74"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 09:39:57.718576) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 09:39:57.718924) ========= 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=6dbc10da6d83fee962c624be000001a8-1472660353.463317-1791477843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 09:39:57.800831) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 09:39:57.801185) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 09:39:57.801514) ========= ========= Total master_lag: 0.17 =========