builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1472857828.24 results: success (0) buildid: 20160902133004 builduid: a2596a45542e4355b38e0b4d86b39cc9 revision: 63d190efe42e5e4984180d315e16b70f6d99618c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 16:10:28.236737) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 16:10:28.237284) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 16:10:28.237597) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 16:10:28.296618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 16:10:28.296961) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-02 16:10:29-- 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.3M=0s 2016-09-02 16:10:29 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125252 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 16:10:28.439318) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 16:10:28.439661) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019527 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 16:10:28.528654) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-02 16:10:28.529085) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 63d190efe42e5e4984180d315e16b70f6d99618c --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 63d190efe42e5e4984180d315e16b70f6d99618c --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=a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-02 16:10:29,608 truncating revision to first 12 chars 2016-09-02 16:10:29,608 Setting DEBUG logging. 2016-09-02 16:10:29,608 attempt 1/10 2016-09-02 16:10:29,608 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/63d190efe42e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-02 16:10:30,374 unpacking tar archive at: mozilla-central-63d190efe42e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.112944 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-02 16:10:29.661079) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 16:10:29.661426) ========= script_repo_revision: 63d190efe42e5e4984180d315e16b70f6d99618c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 16:10:29.661878) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 16:10:29.662220) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 16:10:29.671466) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-09-02 16:10:29.671804) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:10:30 INFO - MultiFileLogger online at 20160902 16:10:30 in /builds/slave/test 16:10:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:10:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:10:30 INFO - {'append_to_log': False, 16:10:30 INFO - 'base_work_dir': '/builds/slave/test', 16:10:30 INFO - 'blob_upload_branch': 'Firefox', 16:10:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:10:30 INFO - 'branch': 'Firefox', 16:10:30 INFO - 'buildbot_json_path': 'buildprops.json', 16:10:30 INFO - 'config_files': ('talos/linux_config.py',), 16:10:30 INFO - 'default_actions': ('clobber', 16:10:30 INFO - 'read-buildbot-config', 16:10:30 INFO - 'download-and-extract', 16:10:30 INFO - 'populate-webroot', 16:10:30 INFO - 'create-virtualenv', 16:10:30 INFO - 'install', 16:10:30 INFO - 'run-tests'), 16:10:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:10:30 INFO - 'download_minidump_stackwalk': True, 16:10:30 INFO - 'download_symbols': 'ondemand', 16:10:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:10:30 INFO - 'tooltool.py': '/tools/tooltool.py', 16:10:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:10:30 INFO - '/tools/misc-python/virtualenv.py')}, 16:10:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:10:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:10:30 INFO - 'installer_path': 'installer.exe', 16:10:30 INFO - 'log_level': 'info', 16:10:30 INFO - 'log_name': 'talos', 16:10:30 INFO - 'log_to_console': True, 16:10:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:10:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:10:30 INFO - 'opt_config_files': (), 16:10:30 INFO - 'pip_index': False, 16:10:30 INFO - 'sps_profile': False, 16:10:30 INFO - 'sps_profile_interval': 0, 16:10:30 INFO - 'suite': 'dromaeojs', 16:10:30 INFO - 'system_bits': '32', 16:10:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:10:30 INFO - 'title': 'talos-linux64-ix-062', 16:10:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:10:30 INFO - 'use_talos_json': True, 16:10:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:10:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:10:30 INFO - 'work_dir': 'build'} 16:10:30 INFO - [mozharness: 2016-09-02 23:10:30.836325Z] Running clobber step. 16:10:30 INFO - Running pre-action listener: _resource_record_pre_action 16:10:30 INFO - Running main action method: clobber 16:10:30 INFO - rmtree: /builds/slave/test/build 16:10:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:10:31 INFO - Running post-action listener: _resource_record_post_action 16:10:31 INFO - [mozharness: 2016-09-02 23:10:31.298148Z] Finished clobber step (success) 16:10:31 INFO - [mozharness: 2016-09-02 23:10:31.298249Z] Running read-buildbot-config step. 16:10:31 INFO - Running pre-action listener: _resource_record_pre_action 16:10:31 INFO - Running main action method: read_buildbot_config 16:10:31 INFO - Using buildbot properties: 16:10:31 INFO - { 16:10:31 INFO - "project": "", 16:10:31 INFO - "product": "firefox", 16:10:31 INFO - "script_repo_revision": "production", 16:10:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:10:31 INFO - "repository": "", 16:10:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 16:10:31 INFO - "buildid": "20160902133004", 16:10:31 INFO - "pgo_build": "True", 16:10:31 INFO - "basedir": "/builds/slave/test", 16:10:31 INFO - "buildnumber": 851, 16:10:31 INFO - "slavename": "talos-linux64-ix-062", 16:10:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:10:31 INFO - "platform": "ubuntu64_hw", 16:10:31 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 16:10:31 INFO - "branch": "mozilla-central", 16:10:31 INFO - "repo_path": "mozilla-central", 16:10:31 INFO - "revision": "63d190efe42e5e4984180d315e16b70f6d99618c", 16:10:31 INFO - "stage_platform": "linux64-pgo", 16:10:31 INFO - "builduid": "a2596a45542e4355b38e0b4d86b39cc9", 16:10:31 INFO - "slavebuilddir": "test" 16:10:31 INFO - } 16:10:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:10:31 INFO - Running post-action listener: _resource_record_post_action 16:10:31 INFO - [mozharness: 2016-09-02 23:10:31.300699Z] Finished read-buildbot-config step (success) 16:10:31 INFO - [mozharness: 2016-09-02 23:10:31.300791Z] Running download-and-extract step. 16:10:31 INFO - Running pre-action listener: _resource_record_pre_action 16:10:31 INFO - Running main action method: download_and_extract 16:10:31 INFO - mkdir: /builds/slave/test/build/tests 16:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:31 INFO - trying https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:10:31 INFO - Downloading https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:10:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:10:31 INFO - Downloaded 1361 bytes. 16:10:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:10:31 INFO - Using the following test package requirements: 16:10:31 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:10:31 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:10:31 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:10:31 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:31 INFO - u'jsshell-linux-x86_64.zip'], 16:10:31 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:10:31 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:10:31 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:10:31 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:10:31 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:10:31 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:10:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:31 INFO - trying https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:10:31 INFO - Downloading https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:10:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:10:32 INFO - Downloaded 21906665 bytes. 16:10:32 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 16:10:36 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:36 INFO - trying https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:10:36 INFO - Downloading https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:10:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:10:37 INFO - Downloaded 21906665 bytes. 16:10:37 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 16:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:42 INFO - trying https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:10:42 INFO - Downloading https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:10:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:10:43 INFO - Downloaded 14413998 bytes. 16:10:43 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 16:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:43 INFO - trying https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:10:43 INFO - Downloading https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:10:44 INFO - Downloaded 59692410 bytes. 16:10:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:10:44 INFO - mkdir: /builds/slave/test/properties 16:10:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:10:44 INFO - Writing to file /builds/slave/test/properties/build_url 16:10:44 INFO - Contents: 16:10:44 INFO - build_url:https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:10:45 INFO - Running post-action listener: _resource_record_post_action 16:10:45 INFO - Running post-action listener: set_extra_try_arguments 16:10:45 INFO - [mozharness: 2016-09-02 23:10:45.393228Z] Finished download-and-extract step (success) 16:10:45 INFO - [mozharness: 2016-09-02 23:10:45.393456Z] Running populate-webroot step. 16:10:45 INFO - Running pre-action listener: _resource_record_pre_action 16:10:45 INFO - Running main action method: populate_webroot 16:10:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:10:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:10:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:10:45 INFO - '--tppagecycles', 16:10:45 INFO - '7'], 16:10:45 INFO - 'tests': ['tsvgm']}}, 16:10:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:10:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:10:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:10:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:10:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:10:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:10:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:45 INFO - 'talos_options': ['--disable-e10s'], 16:10:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:10:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:10:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:45 INFO - 'talos_options': ['--disable-e10s'], 16:10:45 INFO - 'tests': ['damp', 'tps']}, 16:10:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:45 INFO - 'tests': ['damp', 'tps']}, 16:10:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:10:45 INFO - 'tests': ['dromaeo_dom']}, 16:10:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:10:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:10:45 INFO - 'tests': ['basic_compositor_video']}, 16:10:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:10:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:10:45 INFO - 'tests': ['a11yr', 16:10:45 INFO - 'ts_paint', 16:10:45 INFO - 'tpaint', 16:10:45 INFO - 'sessionrestore', 16:10:45 INFO - 'sessionrestore_no_auto_restore', 16:10:45 INFO - 'tabpaint']}, 16:10:45 INFO - 'other-e10s': {'tests': ['a11yr', 16:10:45 INFO - 'ts_paint', 16:10:45 INFO - 'tpaint', 16:10:45 INFO - 'sessionrestore', 16:10:45 INFO - 'sessionrestore_no_auto_restore', 16:10:45 INFO - 'tabpaint']}, 16:10:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:10:45 INFO - 'ts_paint', 16:10:45 INFO - 'tpaint', 16:10:45 INFO - 'sessionrestore', 16:10:45 INFO - 'sessionrestore_no_auto_restore', 16:10:45 INFO - 'tabpaint']}, 16:10:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:10:45 INFO - 'ts_paint', 16:10:45 INFO - 'tpaint', 16:10:45 INFO - 'sessionrestore', 16:10:45 INFO - 'sessionrestore_no_auto_restore', 16:10:45 INFO - 'tabpaint']}, 16:10:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:10:45 INFO - 'tests': ['a11yr', 16:10:45 INFO - 'ts_paint', 16:10:45 INFO - 'tpaint', 16:10:45 INFO - 'sessionrestore', 16:10:45 INFO - 'sessionrestore_no_auto_restore', 16:10:45 INFO - 'tabpaint']}, 16:10:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:10:45 INFO - 'tests': ['a11yr', 16:10:45 INFO - 'ts_paint', 16:10:45 INFO - 'tpaint', 16:10:45 INFO - 'sessionrestore', 16:10:45 INFO - 'sessionrestore_no_auto_restore', 16:10:45 INFO - 'tabpaint']}, 16:10:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:10:45 INFO - 'tests': ['tsvgx', 16:10:45 INFO - 'tsvgr_opacity', 16:10:45 INFO - 'tart', 16:10:45 INFO - 'tscrollx', 16:10:45 INFO - 'cart']}, 16:10:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:10:45 INFO - 'tsvgr_opacity', 16:10:45 INFO - 'tart', 16:10:45 INFO - 'tscrollx', 16:10:45 INFO - 'cart']}, 16:10:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:45 INFO - 'talos_options': ['--disable-e10s'], 16:10:45 INFO - 'tests': ['tp5o']}, 16:10:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:45 INFO - 'tests': ['tp5o']}, 16:10:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:45 INFO - 'talos_options': ['--disable-e10s', 16:10:45 INFO - '--xperf_path', 16:10:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:10:45 INFO - 'tests': ['tp5n']}, 16:10:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:45 INFO - 'talos_options': ['--xperf_path', 16:10:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:10:45 INFO - 'tests': ['tp5n']}}, 16:10:45 INFO - 'talos.zip': {'path': '', 16:10:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:10:45 INFO - Running post-action listener: _resource_record_post_action 16:10:45 INFO - [mozharness: 2016-09-02 23:10:45.411991Z] Finished populate-webroot step (success) 16:10:45 INFO - [mozharness: 2016-09-02 23:10:45.412082Z] Running create-virtualenv step. 16:10:45 INFO - Running pre-action listener: _resource_record_pre_action 16:10:45 INFO - Running main action method: create_virtualenv 16:10:45 INFO - Creating virtualenv /builds/slave/test/build/venv 16:10:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:10:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:10:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:10:45 INFO - Using real prefix '/usr' 16:10:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:10:46 INFO - Installing distribute.............................................................................................................................................................................................done. 16:10:47 INFO - Installing pip.................done. 16:10:47 INFO - Return code: 0 16:10:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:10: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')]} 16:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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')]} 16:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:47 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 0x7f7374b11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1310850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130b370>, '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 0x130e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130ed80>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:10:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:10:47 INFO - Using env: {'DISPLAY': ':0', 16:10:47 INFO - 'HOME': '/home/cltbld', 16:10:47 INFO - 'LANG': 'en_US.UTF-8', 16:10:47 INFO - 'LANGUAGE': 'en_US:en', 16:10:47 INFO - 'LOGNAME': 'cltbld', 16:10:47 INFO - 'MAIL': '/var/mail/cltbld', 16:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:47 INFO - 'MOZ_NO_REMOTE': '1', 16:10:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:47 INFO - 'NO_EM_RESTART': '1', 16:10:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:47 INFO - 'PWD': '/builds/slave/test', 16:10:47 INFO - 'SHELL': '/bin/bash', 16:10:47 INFO - 'SHLVL': '1', 16:10:47 INFO - 'TERM': 'linux', 16:10:47 INFO - 'TMOUT': '86400', 16:10:47 INFO - 'USER': 'cltbld', 16:10:47 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366', 16:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:47 INFO - '_': '/tools/buildbot/bin/python'} 16:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:10:48 INFO - Cleaning up... 16:10:48 INFO - Return code: 0 16:10:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7374b11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1310850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130b370>, '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 0x130e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130ed80>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:10:48 INFO - Using env: {'DISPLAY': ':0', 16:10:48 INFO - 'HOME': '/home/cltbld', 16:10:48 INFO - 'LANG': 'en_US.UTF-8', 16:10:48 INFO - 'LANGUAGE': 'en_US:en', 16:10:48 INFO - 'LOGNAME': 'cltbld', 16:10:48 INFO - 'MAIL': '/var/mail/cltbld', 16:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:48 INFO - 'MOZ_NO_REMOTE': '1', 16:10:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:48 INFO - 'NO_EM_RESTART': '1', 16:10:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:48 INFO - 'PWD': '/builds/slave/test', 16:10:48 INFO - 'SHELL': '/bin/bash', 16:10:48 INFO - 'SHLVL': '1', 16:10:48 INFO - 'TERM': 'linux', 16:10:48 INFO - 'TMOUT': '86400', 16:10:48 INFO - 'USER': 'cltbld', 16:10:48 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366', 16:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:48 INFO - '_': '/tools/buildbot/bin/python'} 16:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:48 INFO - Downloading/unpacking psutil>=3.1.1 16:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:10:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:10:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:10:50 INFO - Installing collected packages: psutil 16:10:50 INFO - Running setup.py install for psutil 16:10:50 INFO - building 'psutil._psutil_linux' extension 16:10:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:10:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:10:50 INFO - building 'psutil._psutil_posix' extension 16:10:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:10:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:10:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:10:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:10:50 INFO - Successfully installed psutil 16:10:50 INFO - Cleaning up... 16:10:50 INFO - Return code: 0 16:10:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:50 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 0x7f7374b11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1310850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130b370>, '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 0x130e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130ed80>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:10:50 INFO - Using env: {'DISPLAY': ':0', 16:10:50 INFO - 'HOME': '/home/cltbld', 16:10:50 INFO - 'LANG': 'en_US.UTF-8', 16:10:50 INFO - 'LANGUAGE': 'en_US:en', 16:10:50 INFO - 'LOGNAME': 'cltbld', 16:10:50 INFO - 'MAIL': '/var/mail/cltbld', 16:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:50 INFO - 'MOZ_NO_REMOTE': '1', 16:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:50 INFO - 'NO_EM_RESTART': '1', 16:10:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:50 INFO - 'PWD': '/builds/slave/test', 16:10:50 INFO - 'SHELL': '/bin/bash', 16:10:50 INFO - 'SHLVL': '1', 16:10:50 INFO - 'TERM': 'linux', 16:10:50 INFO - 'TMOUT': '86400', 16:10:50 INFO - 'USER': 'cltbld', 16:10:50 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366', 16:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:50 INFO - '_': '/tools/buildbot/bin/python'} 16:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:10:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:10:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:10:53 INFO - Installing collected packages: mozsystemmonitor 16:10:53 INFO - Running setup.py install for mozsystemmonitor 16:10:53 INFO - Successfully installed mozsystemmonitor 16:10:53 INFO - Cleaning up... 16:10:53 INFO - Return code: 0 16:10:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7374b11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1310850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130b370>, '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 0x130e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130ed80>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:10:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:10:53 INFO - Using env: {'DISPLAY': ':0', 16:10:53 INFO - 'HOME': '/home/cltbld', 16:10:53 INFO - 'LANG': 'en_US.UTF-8', 16:10:53 INFO - 'LANGUAGE': 'en_US:en', 16:10:53 INFO - 'LOGNAME': 'cltbld', 16:10:53 INFO - 'MAIL': '/var/mail/cltbld', 16:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:53 INFO - 'MOZ_NO_REMOTE': '1', 16:10:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:53 INFO - 'NO_EM_RESTART': '1', 16:10:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:53 INFO - 'PWD': '/builds/slave/test', 16:10:53 INFO - 'SHELL': '/bin/bash', 16:10:53 INFO - 'SHLVL': '1', 16:10:53 INFO - 'TERM': 'linux', 16:10:53 INFO - 'TMOUT': '86400', 16:10:53 INFO - 'USER': 'cltbld', 16:10:53 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366', 16:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:53 INFO - '_': '/tools/buildbot/bin/python'} 16:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:53 INFO - Downloading/unpacking jsonschema==2.5.1 16:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:10:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:55 INFO - Downloading functools32-3.2.3-2.tar.gz 16:10:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:10:55 INFO - warning: no files found matching '*.txt' 16:10:55 INFO - no previously-included directories found matching 'build' 16:10:55 INFO - no previously-included directories found matching 'dist' 16:10:55 INFO - no previously-included directories found matching '.git*' 16:10:55 INFO - Installing collected packages: jsonschema, functools32 16:10:55 INFO - Running setup.py install for functools32 16:10:55 INFO - warning: no files found matching '*.txt' 16:10:55 INFO - no previously-included directories found matching 'build' 16:10:55 INFO - no previously-included directories found matching 'dist' 16:10:55 INFO - no previously-included directories found matching '.git*' 16:10:55 INFO - Successfully installed jsonschema functools32 16:10:55 INFO - Cleaning up... 16:10:55 INFO - Return code: 0 16:10:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:55 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 0x7f7374b11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1310850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130b370>, '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 0x130e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130ed80>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:10:55 INFO - Using env: {'DISPLAY': ':0', 16:10:55 INFO - 'HOME': '/home/cltbld', 16:10:55 INFO - 'LANG': 'en_US.UTF-8', 16:10:55 INFO - 'LANGUAGE': 'en_US:en', 16:10:55 INFO - 'LOGNAME': 'cltbld', 16:10:55 INFO - 'MAIL': '/var/mail/cltbld', 16:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:55 INFO - 'MOZ_NO_REMOTE': '1', 16:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:55 INFO - 'NO_EM_RESTART': '1', 16:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:55 INFO - 'PWD': '/builds/slave/test', 16:10:55 INFO - 'SHELL': '/bin/bash', 16:10:55 INFO - 'SHLVL': '1', 16:10:55 INFO - 'TERM': 'linux', 16:10:55 INFO - 'TMOUT': '86400', 16:10:55 INFO - 'USER': 'cltbld', 16:10:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366', 16:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:55 INFO - '_': '/tools/buildbot/bin/python'} 16:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:10:56 INFO - Cleaning up... 16:10:56 INFO - Return code: 0 16:10:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7374b11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1310850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130b370>, '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 0x130e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130ed80>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:10:56 INFO - Using env: {'DISPLAY': ':0', 16:10:56 INFO - 'HOME': '/home/cltbld', 16:10:56 INFO - 'LANG': 'en_US.UTF-8', 16:10:56 INFO - 'LANGUAGE': 'en_US:en', 16:10:56 INFO - 'LOGNAME': 'cltbld', 16:10:56 INFO - 'MAIL': '/var/mail/cltbld', 16:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:56 INFO - 'MOZ_NO_REMOTE': '1', 16:10:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:56 INFO - 'NO_EM_RESTART': '1', 16:10:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:56 INFO - 'PWD': '/builds/slave/test', 16:10:56 INFO - 'SHELL': '/bin/bash', 16:10:56 INFO - 'SHLVL': '1', 16:10:56 INFO - 'TERM': 'linux', 16:10:56 INFO - 'TMOUT': '86400', 16:10:56 INFO - 'USER': 'cltbld', 16:10:56 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366', 16:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:56 INFO - '_': '/tools/buildbot/bin/python'} 16:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:56 INFO - Downloading/unpacking blobuploader==1.2.4 16:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:58 INFO - Downloading blobuploader-1.2.4.tar.gz 16:10:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:10:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:10:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:58 INFO - Downloading docopt-0.6.1.tar.gz 16:10:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:10:58 INFO - Installing collected packages: blobuploader, requests, docopt 16:10:58 INFO - Running setup.py install for blobuploader 16:10:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:10:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:10:58 INFO - Running setup.py install for requests 16:10:59 INFO - Running setup.py install for docopt 16:10:59 INFO - Successfully installed blobuploader requests docopt 16:10:59 INFO - Cleaning up... 16:10:59 INFO - Return code: 0 16:10:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7374b11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1310850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130b370>, '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 0x130e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130ed80>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:10:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:10:59 INFO - Using env: {'DISPLAY': ':0', 16:10:59 INFO - 'HOME': '/home/cltbld', 16:10:59 INFO - 'LANG': 'en_US.UTF-8', 16:10:59 INFO - 'LANGUAGE': 'en_US:en', 16:10:59 INFO - 'LOGNAME': 'cltbld', 16:10:59 INFO - 'MAIL': '/var/mail/cltbld', 16:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:59 INFO - 'MOZ_NO_REMOTE': '1', 16:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:59 INFO - 'NO_EM_RESTART': '1', 16:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:59 INFO - 'PWD': '/builds/slave/test', 16:10:59 INFO - 'SHELL': '/bin/bash', 16:10:59 INFO - 'SHLVL': '1', 16:10:59 INFO - 'TERM': 'linux', 16:10:59 INFO - 'TMOUT': '86400', 16:10:59 INFO - 'USER': 'cltbld', 16:10:59 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366', 16:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:59 INFO - '_': '/tools/buildbot/bin/python'} 16:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:10:59 INFO - Running setup.py (path:/tmp/pip-Y5bFrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:10:59 INFO - Running setup.py (path:/tmp/pip-mYKnSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:10:59 INFO - Running setup.py (path:/tmp/pip-kX8o2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:10:59 INFO - Running setup.py (path:/tmp/pip-KkyMy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:11:00 INFO - Running setup.py (path:/tmp/pip-s9pNXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:11:00 INFO - Running setup.py (path:/tmp/pip-GOInAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:11:00 INFO - Running setup.py (path:/tmp/pip-wb8mZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:11:00 INFO - Running setup.py (path:/tmp/pip-5LsjDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:11:00 INFO - Running setup.py (path:/tmp/pip-bizQzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:11:00 INFO - Running setup.py (path:/tmp/pip-EkVHui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:11:00 INFO - Running setup.py (path:/tmp/pip-lDX6lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:11:00 INFO - Running setup.py (path:/tmp/pip-NJAMr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:11:00 INFO - Running setup.py (path:/tmp/pip-jo8fQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:11:00 INFO - Running setup.py (path:/tmp/pip-ncUj8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:00 INFO - Running setup.py (path:/tmp/pip-XZoNKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:11:00 INFO - Running setup.py (path:/tmp/pip-Ux5gck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:11:00 INFO - Running setup.py (path:/tmp/pip-gPMt8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:11:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:11:00 INFO - Running setup.py install for manifestparser 16:11:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:11:01 INFO - Running setup.py install for mozcrash 16:11:01 INFO - Running setup.py install for mozdebug 16:11:01 INFO - Running setup.py install for mozdevice 16:11:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:11:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:11:01 INFO - Running setup.py install for mozfile 16:11:01 INFO - Running setup.py install for mozhttpd 16:11:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:11:01 INFO - Running setup.py install for mozinfo 16:11:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:11:01 INFO - Running setup.py install for mozInstall 16:11:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:11:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:11:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:11:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:11:01 INFO - Running setup.py install for mozleak 16:11:01 INFO - Running setup.py install for mozlog 16:11:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:11:02 INFO - Running setup.py install for moznetwork 16:11:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:11:02 INFO - Running setup.py install for mozprocess 16:11:02 INFO - Running setup.py install for mozprofile 16:11:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:11:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:11:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:11:02 INFO - Running setup.py install for mozrunner 16:11:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:11:02 INFO - Running setup.py install for mozscreenshot 16:11:02 INFO - Running setup.py install for moztest 16:11:02 INFO - Running setup.py install for mozversion 16:11:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:11:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:11:02 INFO - Cleaning up... 16:11:02 INFO - Return code: 0 16:11:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:02 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 0x7f7374b11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1310850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130b370>, '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 0x130e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130ed80>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:11:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:11:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:11:02 INFO - Using env: {'DISPLAY': ':0', 16:11:02 INFO - 'HOME': '/home/cltbld', 16:11:02 INFO - 'LANG': 'en_US.UTF-8', 16:11:02 INFO - 'LANGUAGE': 'en_US:en', 16:11:02 INFO - 'LOGNAME': 'cltbld', 16:11:02 INFO - 'MAIL': '/var/mail/cltbld', 16:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:02 INFO - 'MOZ_NO_REMOTE': '1', 16:11:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:02 INFO - 'NO_EM_RESTART': '1', 16:11:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:02 INFO - 'PWD': '/builds/slave/test', 16:11:02 INFO - 'SHELL': '/bin/bash', 16:11:02 INFO - 'SHLVL': '1', 16:11:02 INFO - 'TERM': 'linux', 16:11:02 INFO - 'TMOUT': '86400', 16:11:02 INFO - 'USER': 'cltbld', 16:11:02 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366', 16:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:02 INFO - '_': '/tools/buildbot/bin/python'} 16:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:11:02 INFO - Running setup.py (path:/tmp/pip-qbwcLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:11:03 INFO - Running setup.py (path:/tmp/pip-dRKPDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:11:03 INFO - Running setup.py (path:/tmp/pip-YdhNak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:11:03 INFO - Running setup.py (path:/tmp/pip-q_3hYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:11:03 INFO - Running setup.py (path:/tmp/pip-jKUXSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:11:03 INFO - Running setup.py (path:/tmp/pip-5hqp5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:11:03 INFO - Running setup.py (path:/tmp/pip-GBJnF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:11:03 INFO - Running setup.py (path:/tmp/pip-wAs9rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:11:03 INFO - Running setup.py (path:/tmp/pip-iCgPAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:11:03 INFO - Running setup.py (path:/tmp/pip-Ertrqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:11:03 INFO - Running setup.py (path:/tmp/pip-wNg_RH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:11:03 INFO - Running setup.py (path:/tmp/pip-PQZlT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:11:03 INFO - Running setup.py (path:/tmp/pip-q1_tFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:11:03 INFO - Running setup.py (path:/tmp/pip-Ikf783-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:04 INFO - Running setup.py (path:/tmp/pip-3CmB5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:11:04 INFO - Running setup.py (path:/tmp/pip-5YSgBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:11:04 INFO - Running setup.py (path:/tmp/pip-iJYtKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:11:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:06 INFO - Downloading blessings-1.6.tar.gz 16:11:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:11:06 INFO - Installing collected packages: blessings 16:11:06 INFO - Running setup.py install for blessings 16:11:06 INFO - Successfully installed blessings 16:11:06 INFO - Cleaning up... 16:11:06 INFO - Return code: 0 16:11:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:11:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:11:06 INFO - Reading from file tmpfile_stdout 16:11:06 INFO - Current package versions: 16:11:06 INFO - argparse == 1.2.1 16:11:06 INFO - blessings == 1.6 16:11:06 INFO - blobuploader == 1.2.4 16:11:06 INFO - docopt == 0.6.1 16:11:06 INFO - functools32 == 3.2.3-2 16:11:06 INFO - jsonschema == 2.5.1 16:11:06 INFO - manifestparser == 1.1 16:11:06 INFO - mozInstall == 1.12 16:11:06 INFO - mozcrash == 0.17 16:11:06 INFO - mozdebug == 0.1 16:11:06 INFO - mozdevice == 0.48 16:11:06 INFO - mozfile == 1.2 16:11:06 INFO - mozhttpd == 0.7 16:11:06 INFO - mozinfo == 0.9 16:11:06 INFO - mozleak == 0.1 16:11:06 INFO - mozlog == 3.3 16:11:06 INFO - moznetwork == 0.27 16:11:06 INFO - mozprocess == 0.23 16:11:06 INFO - mozprofile == 0.28 16:11:06 INFO - mozrunner == 6.12 16:11:06 INFO - mozscreenshot == 0.1 16:11:06 INFO - mozsystemmonitor == 0.3 16:11:06 INFO - moztest == 0.7 16:11:06 INFO - mozversion == 1.4 16:11:06 INFO - psutil == 3.1.1 16:11:06 INFO - requests == 1.2.3 16:11:06 INFO - wsgiref == 0.1.2 16:11:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7374b11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1310850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130b370>, '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 0x130e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130ed80>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:11:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:11:06 INFO - Using env: {'DISPLAY': ':0', 16:11:06 INFO - 'HOME': '/home/cltbld', 16:11:06 INFO - 'LANG': 'en_US.UTF-8', 16:11:06 INFO - 'LANGUAGE': 'en_US:en', 16:11:06 INFO - 'LOGNAME': 'cltbld', 16:11:06 INFO - 'MAIL': '/var/mail/cltbld', 16:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:06 INFO - 'MOZ_NO_REMOTE': '1', 16:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:06 INFO - 'NO_EM_RESTART': '1', 16:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:06 INFO - 'PWD': '/builds/slave/test', 16:11:06 INFO - 'SHELL': '/bin/bash', 16:11:06 INFO - 'SHLVL': '1', 16:11:06 INFO - 'TERM': 'linux', 16:11:06 INFO - 'TMOUT': '86400', 16:11:06 INFO - 'USER': 'cltbld', 16:11:06 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366', 16:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:06 INFO - '_': '/tools/buildbot/bin/python'} 16:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:11:06 INFO - Cleaning up... 16:11:06 INFO - Return code: 0 16:11:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:06 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 0x7f7374b11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1310850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130b370>, '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 0x130e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130ed80>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:11:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:11:06 INFO - Using env: {'DISPLAY': ':0', 16:11:06 INFO - 'HOME': '/home/cltbld', 16:11:06 INFO - 'LANG': 'en_US.UTF-8', 16:11:06 INFO - 'LANGUAGE': 'en_US:en', 16:11:06 INFO - 'LOGNAME': 'cltbld', 16:11:06 INFO - 'MAIL': '/var/mail/cltbld', 16:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:06 INFO - 'MOZ_NO_REMOTE': '1', 16:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:06 INFO - 'NO_EM_RESTART': '1', 16:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:06 INFO - 'PWD': '/builds/slave/test', 16:11:06 INFO - 'SHELL': '/bin/bash', 16:11:06 INFO - 'SHLVL': '1', 16:11:06 INFO - 'TERM': 'linux', 16:11:06 INFO - 'TMOUT': '86400', 16:11:06 INFO - 'USER': 'cltbld', 16:11:06 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366', 16:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:06 INFO - '_': '/tools/buildbot/bin/python'} 16:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:11:07 INFO - Cleaning up... 16:11:07 INFO - Return code: 0 16:11:07 INFO - Running post-action listener: _resource_record_post_action 16:11:07 INFO - Running post-action listener: _start_resource_monitoring 16:11:07 INFO - Starting resource monitoring. 16:11:07 INFO - [mozharness: 2016-09-02 23:11:07.040968Z] Finished create-virtualenv step (success) 16:11:07 INFO - [mozharness: 2016-09-02 23:11:07.041556Z] Running install step. 16:11:07 INFO - Running pre-action listener: _resource_record_pre_action 16:11:07 INFO - Running main action method: install 16:11:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:11:07 INFO - Reading from file tmpfile_stdout 16:11:07 INFO - Detecting whether we're running mozinstall >=1.0... 16:11:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:11:07 INFO - Reading from file tmpfile_stdout 16:11:07 INFO - Output received: 16:11:07 INFO - Usage: mozinstall [options] installer 16:11:07 INFO - Options: 16:11:07 INFO - -h, --help show this help message and exit 16:11:07 INFO - -d DEST, --destination=DEST 16:11:07 INFO - Directory to install application into. [default: 16:11:07 INFO - "/builds/slave/test"] 16:11:07 INFO - --app=APP Application being installed. [default: firefox] 16:11:07 INFO - mkdir: /builds/slave/test/build/application 16:11:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:11:24 INFO - Reading from file tmpfile_stdout 16:11:24 INFO - Output received: 16:11:24 INFO - /builds/slave/test/build/application/firefox/firefox 16:11:24 INFO - Running post-action listener: _resource_record_post_action 16:11:24 INFO - [mozharness: 2016-09-02 23:11:24.371740Z] Finished install step (success) 16:11:24 INFO - [mozharness: 2016-09-02 23:11:24.372082Z] Running run-tests step. 16:11:24 INFO - Running pre-action listener: _resource_record_pre_action 16:11:24 INFO - Running main action method: run_tests 16:11:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:11:24 INFO - Python 2.7.3 16:11:24 INFO - Return code: 0 16:11:24 INFO - grabbing minidump binary from tooltool 16:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:24 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 0x130b370>, '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 0x130e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130ed80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:11:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:11:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:11:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:11:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:11:24 INFO - Return code: 0 16:11:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:11:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:11:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:11:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:11:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:11:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:11:24 INFO - Using env: {'DISPLAY': ':0', 16:11:24 INFO - 'HOME': '/home/cltbld', 16:11:24 INFO - 'LANG': 'en_US.UTF-8', 16:11:24 INFO - 'LANGUAGE': 'en_US:en', 16:11:24 INFO - 'LOGNAME': 'cltbld', 16:11:24 INFO - 'MAIL': '/var/mail/cltbld', 16:11:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:11:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:24 INFO - 'MOZ_NO_REMOTE': '1', 16:11:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:24 INFO - 'NO_EM_RESTART': '1', 16:11:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:24 INFO - 'PWD': '/builds/slave/test', 16:11:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:11:24 INFO - 'SHELL': '/bin/bash', 16:11:24 INFO - 'SHLVL': '1', 16:11:24 INFO - 'TERM': 'linux', 16:11:24 INFO - 'TMOUT': '86400', 16:11:24 INFO - 'USER': 'cltbld', 16:11:24 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366', 16:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:24 INFO - '_': '/tools/buildbot/bin/python'} 16:11:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:11:24 INFO - mozversion application_buildid: 20160902133004 16:11:24 INFO - mozversion application_changeset: 63d190efe42e5e4984180d315e16b70f6d99618c 16:11:24 INFO - mozversion application_display_name: Nightly 16:11:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:11:24 INFO - mozversion application_name: Firefox 16:11:24 INFO - mozversion application_remotingname: firefox 16:11:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:11:24 INFO - mozversion application_vendor: Mozilla 16:11:24 INFO - mozversion application_version: 51.0a1 16:11:24 INFO - mozversion platform_buildid: 20160902133004 16:11:24 INFO - mozversion platform_changeset: 63d190efe42e5e4984180d315e16b70f6d99618c 16:11:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:11:24 INFO - mozversion platform_version: 51.0a1 16:11:24 INFO - using testdate: 1472857884 16:11:24 INFO - actual date: 1472857884 16:11:24 INFO - starting webserver on 'localhost:54597' 16:11:24 INFO - SUITE-START | Running 2 tests 16:11:24 INFO - TEST-START | dromaeo_css 16:11:24 INFO - operating with platform_type : linux_ 16:11:24 INFO - Initialising browser for dromaeo_css test... 16:11:24 INFO - TEST-INFO | started process 32047 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYBADK2/profile http://localhost:54597/getInfo.html) 16:11:28 INFO - PROCESS | 32047 | __metrics Screen width/height:1600/1200 16:11:28 INFO - PROCESS | 32047 | colorDepth:24 16:11:28 INFO - PROCESS | 32047 | Browser inner width/height: 1024/697 16:11:28 INFO - PROCESS | 32047 | __metrics 16:11:29 INFO - PROCESS | 32047 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:11:29 INFO - PROCESS | 32047 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:11:30 INFO - TEST-INFO | 32047: exit 0 16:11:30 INFO - Browser initialized. 16:11:30 INFO - Running cycle 1/1 for dromaeo_css test... 16:11:30 INFO - TEST-INFO | started process 32130 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYBADK2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:11:42 INFO - PROCESS | 32130 | RSS: Main: 179650560 16:11:42 INFO - PROCESS | 32130 | 16:12:33 INFO - PROCESS | 32130 | 1472857953945 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:14:43 INFO - PROCESS | 32130 | Cycle 1(1): loaded http://localhost:54597/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54597/tests/dromaeo/cssquery-ext.html) 16:14:44 INFO - PROCESS | 32130 | RSS: Main: 304513024 16:14:44 INFO - PROCESS | 32130 | 16:17:46 INFO - PROCESS | 32130 | Cycle 1(1): loaded http://localhost:54597/tests/dromaeo/cssquery-ext.html (next: http://localhost:54597/tests/dromaeo/cssquery-jquery.html) 16:17:47 INFO - PROCESS | 32130 | RSS: Main: 268382208 16:17:47 INFO - PROCESS | 32130 | 16:20:49 INFO - PROCESS | 32130 | Cycle 1(1): loaded http://localhost:54597/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54597/tests/dromaeo/cssquery-mootools.html) 16:20:49 INFO - PROCESS | 32130 | RSS: Main: 216150016 16:20:49 INFO - PROCESS | 32130 | 16:23:52 INFO - PROCESS | 32130 | Cycle 1(1): loaded http://localhost:54597/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54597/tests/dromaeo/cssquery-prototype.html) 16:23:52 INFO - PROCESS | 32130 | RSS: Main: 242905088 16:23:52 INFO - PROCESS | 32130 | 16:26:55 INFO - PROCESS | 32130 | Cycle 1(1): loaded http://localhost:54597/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54597/tests/dromaeo/cssquery-yui.html) 16:26:56 INFO - PROCESS | 32130 | RSS: Main: 216203264 16:26:56 INFO - PROCESS | 32130 | 16:29:58 INFO - PROCESS | 32130 | Cycle 1(1): loaded http://localhost:54597/tests/dromaeo/cssquery-yui.html (next: http://localhost:54597/tests/dromaeo/cssquery-dojo.html) 16:29:58 INFO - PROCESS | 32130 | RSS: Main: 299118592 16:29:58 INFO - PROCESS | 32130 | 16:29:58 INFO - PROCESS | 32130 | __start_tp_report 16:29:58 INFO - PROCESS | 32130 | _x_x_mozilla_page_load 16:29:58 INFO - PROCESS | 32130 | _x_x_mozilla_page_load_details 16:29:58 INFO - PROCESS | 32130 | |i|pagename|runs| 16:29:58 INFO - PROCESS | 32130 | |0;dojo.html;2981.865816038278;2985.6715761266255;3008.9548656770153;3036.1347016100417;3061.7244447999674;5032.572231360339;5175.637705360627;5177.068127737006;5238.18808084747;5279.128943724286;5148.974255128728;5179.8446046618665;5208.453112423188;5249.370075590934;5292.444293349201;4657.720536767788;4763.666543341968;4783.139034973703;4819.6867203631655;4947.1589829728855;4841.951580484185;4866.51334866514;4886.48691887352;4889.437714662824;4913.336699545552;4623.976880115595;4697.037107392976;4752.7861246244;4764.928526072112;4785.617150627959;4662.790174442158;4677.50886156952;4695.272232803921;4749.833755818564;4806.759662016885;4710.693804902705;4725.054989002213;4729.527047295277;4735.976320118411;4738.83414080509;5050.318207042076;5068.619853511002;5118.923216151761;5151.304573882516;5209.218617207412;5461.42655021225;5476.67139971603;5507.339119305669;5538.086215774392;5543.196236545678;5533.584981126432;5538.141588053818;5569.969555632221;5591.692456914868;5599.877338846486;5107.361579802525;5161.277421161003;5191;5196.506331898426;5261.973690131525;5674.035413979551;5680.346760122557;5680.801171958961;5734.426557344233;5744.569157313134;5451.591130665216;5458.781648734006;5458.935507576064;5461.399246082928;5462.808801691922;5290.523852853262;5495.395506494282;5547;5557;5631.239782629293;5523.944760552424;5535.889282214333;5537.252470916455;5538.390777014525;5542.528885044816;5537.778488860481;5540.972295138579;5545.390007099216;5554.666719996732;5628.71856407178;4224.070704445017;4323.459567554056;4372.956270437318;4381.036172042146;4425.424694789656;3887.4168874669026;3897.2595206910596;3902.20004898995;3944.7633142010995;3949.190415964778;5296.788128474818;5322.973385133127;5343.770932685504;5358.732063396815;5365.490278423544;5486.1222204447095;5593.664380137205;5623.634463759842;5658;5741;5341.919871201935;5369.865753356197;5373.925214956946;5374.758135883894;5378.596605254622;4931.975340123348;4940.530649588283;4943.950560494349;4946.406431228275;4997.5002499749735;5635.042042852725;5745.569082318842;5763.394843541451;5790.652560846363;5886.6173698709445;5637.8590535236945;5638.041532939328;5638.4925356718095;5643.576731745054;5644.971775141098;5795.072788353843;5796.1305804129715;5797.797077102281;5804.042333015174;5811.651300921958;5317.1492561190025;5385.596080293915;5424.267723857229;5433.619646624857;5482.314710661168;5542.501174894279;5584.162375643686;5594.944050559442;5599.496045355938;5600.047991841316;5468.945310547003;5475.561955043508;5481.75332110048;5483.424240454695;5496.450354964471;5368.731563421735;5432.674039557639;5455.1271796512365;5461.317335333083;5585.162225666182;5493.340799104133;5496.587755918402;5499.670019798825;5499.917501237404;5504.146857237135;5527.088030474926;5549.833504994856;5554.888902221852;5555.0834112371;5619.662820230799;5292.126799078109;5347;5349.705766182898;5417.593680473901;5421.864453388697 16:29:58 INFO - PROCESS | 32130 | |1;ext.html;546.9219626122176;601.4136217188242;608.6226539545481;614.2536817766415;624.5534442873345;33325;34802.47796283058;34837.651623483755;42557.57442425575;43452;45078.32382514265;45639.08721825561;45839;45955.31067033997;46229.76885115578;8964.282857371394;9095.226905713022;9102.726918192431;9113.134252246025;9128.224100951395;8974.50640214788;9060.184583387494;9062.682806101788;9070.591823367964;9086.86369704455;9087.591058402388;9102.271818254558;9109.99790023097;9116;9124.361294709373;9106.863397049017;9138.497382643953;9139;9143.908560914406;9145.679901203492;8902.510361930092;8977.685780997634;9017.819643607158;9080.22818060459;9084.50035248061;42736.78631606853;42790;43314.566854331366;43316.78341608303;43327.78336108331;3432.8970130896114;3560.6439356064448;3579.83890724918;4020.7587544747407;4232.365145228209;30924;32589.348213035606;32662.346753065045;33013;34147.6585234147;4322.459692538433;4402.3176407656865;4414.624756895668;4419.469663640351;4472.306792447176;374262;376015;376680;376857;378154;51825;61057.389426106056;61325.69337153375;61418.69290653518;61431.38568614257;63415;64394.678026610505;64567.677161613894;70606;70672.64663676752;15521.301541430663;15542.766858497132;15555.144467054195;15565.29956151976;15588.766168507482;11751.588694395656;12533;12596.55912043074;12597;12598.748025039447;19015.904920475587;19485.90257048706;19490.220391184193;19661.606767864563;19792.802071979382;7248.782536523912;7334.926650733424;7401.740939067106;7490.363319117936;7612.885806712904;978.4862946952907;1038.8441733739999;1082.6643740440488;1128.2779021426293;1145.73075327298;33307.666923330944;33467;33474.66525334716;33591;33684;1039.8180318444242;1088.1458055426451;1116.436199719153;1123.4775829239443;1135.437958210691;16567.668646627;17456.47630571085;17548.736768948474;17574.736378954327;17611.295548177928;556452;561761;561978;563048;563710;59995;60563;60581.69709151514;60599.394006060254;60629.69685151546;1236.8330275412704;1335.2989680417859;1358.4634069542674;1373.7870630052157;1375.2848518770184;31684.207894802814;33155.33689326248;33921.32157356889;33969;34556.30887382288;49175.75412122916;50270.24594631157;50273;50276.245856311456;50358.74820625874;409995;411593.84061593603;414618;416295;417104;28605.713942860304;29651.851740742022;29862.85068574643;30927.381452371275;30929.20597307421;48693;48751.806168721785;48835.755821220664;48900.75549622229;49313.26030109479;41469;41742;42081;42267.7886610565;43515.12969740524;40835;41178;41531.37702934398;42038;42610.57389426066;41302;41899;42169.36745948875;42376.78811606046;42762.78618606887;40100.598994009684;41008;43481;43861.56138438575;44061;32142.83928580342;34843.82578087093;34944.82527587346;35060.824695877374;35120 16:29:58 INFO - PROCESS | 32130 | |2;jquery.html;383.54549858417795;398.09433538699454;405.8924385037964;409.94260803487515;423.3353634793374;15197.544073677793;18651.62696746064;18783.3425830096;19698.70451943222;19769.604607907833;18062.18720157593;18170.727439088423;18487;18671.71992420115;18709.34517291892;5410.648307859996;5467.917981230285;5611.691356975365;5707;5709.71451427429;5609.775608975636;5619.438056194368;5624.831255062355;5629.6340737852115;5641;5575.358833734132;5613.101903695409;5619.129034999582;5623;5795.82612521625;5899.203607512974;5949.25634295713;5960.970195148997;5976.7908123215475;6010.248718910137;5578.386377498472;5769.740361683735;5779.595428320019;5822.359540450547;5831.271091113611;13075.411606477732;13122.278274694889;13400.79898801509;13709.588712338646;13717.382717777624;2227.12028748645;2309;2354.329016230366;2666.266776636421;2902.4630443368046;10776;11303.491342889589;13012;14043.719125617532;14770.113793172444;1809.3576780242956;1818.354484158118;1848.0944337274773;1871.0925201277369;1921.3563456242036;76324.61837690831;84327.0971032028;84940;85389.57305213434;86978;9259.490728009889;9609.183219426428;9762.414255144571;10859.674209773719;11202.047825934724;12489.250644961332;13237.867621323663;13261.801072983913;13331.133476324008;13342.733145337039;7515.286047825448;7614.314711675865;7713.7685869424;7925.920740792633;7927.960360198162;7427.851442971219;7693.615319234016;7745.690172393154;7759.612019399007;7940.205979402013;4005.6595189409227;4015.799210039545;4109.589041095926;4223.957760422357;4269.295566231537;1963.9509012274807;1993.2226431691652;2025.8885761282977;2029.3911826452006;2035.714999900015;867.3321542412307;960.188640598693;968.138356862393;1011.0041609015115;1024.3546565663585;17703.73444398335;18447.53881152982;18901.905490472458;19230.03849807504;19639.410817675493;961.3895176562933;969.6896992962185;980.578351308944;986.7582442301539;996.8056229035268;9990.650327238513;10296.22778291631;10413.895861041445;10430.37417754922;10502.212334074975;505578;506656;509630.2295816326;509728;511918;86341;95630;97439.025609743;98498.50750746201;99105.50447247717;996.6063404955147;1023.7696518283327;1040.7710303733168;1050.3592808386877;1058.1904842795268;16309.347626094823;16497.752533712242;16959.406420775213;17411.651766964842;17422.912885436;39881;40019.3997090038;40925.386119207644;41792.58207417887;42227.788861056724;55301.170482441994;56542.43457565536;56808.43191568032;58418.70790646019;59367.703161485646;8234;8433.19884610961;8442.493450392996;8606.44058136219;8867.512286824287;10557.63048293306;12674.619761407173;12686.746265074831;12978.156419832681;13251.86748132545;10716.249862509549;10904.34573925567;10946.616868409568;11091.611793587186;11213.271137376045;5532.2254884317035;9825.705228843146;10445.843312350169;11125;11404.48679809394;10920.890791091988;11090.667279981613;11128.833067504156;11215.66353009411;11223.831642525533;8237.876431853407;8318.334533237448;8374.53940033304;8421.157884211774;8658.350623703122;8982.86525702128;11243.4378281084;11255.212135150461;11371.772564548828;11559.884401155881 16:29:58 INFO - PROCESS | 32130 | |3;mootools.html;1340.6648337915522;1454.4182327069175;1504.969900601988;1565.4833904811414;1705.7611934329204;8450.492970421772;8844.690435834747;8863.069377715343;9048.683296084639;9062.728118156449;8850.159234872694;8941.64233430662;8945.776355591113;8949.328800339985;8964.820703585925;2086.488810241493;2291.163725240292;2427.296084135603;2438.9878050609723;2458.2870967419426;2419.758024197584;2454.9386265343333;2456.570100232452;2456.6069428891383;2457.680501534798;2349.2717257650097;2353.635186546088;2371.4071482129466;2408.9280270279733;2417.613181890898;2019.6667549854403;2298.5632729781287;2308.826837987158;2311.9537609247723;2393.066703985447;2376.560336337783;2401.4956859059616;2405.687260656121;2406.651035599828;2407.6749638798715;8986.55067246635;9006.639734410615;9025.368224224307;9043.864342034874;9056.184943355063;5127.769250383742;5234.42421333653;5248.947510524884;5251.369835619712;5260.8684782880355;3281.1305004173914;3324.6176689680756;3472.722182225441;3479.182392137871;3479.704225140866;1075.8924107589257;1090.3076546393017;1096.9524104480201;1102.3881745631172;1139.2651739627977;12348.814767778491;12404.75190496185;12444;12449.75100497994;12471.438785254686;4770.0936822003705;4792.808287668524;4820.132376172322;4882.389701287339;4921.827736029293;10434.21743369235;10452.425116618659;10460.476976151162;10471.214658900613;10476.371417714961;5384.9730751346;5405.945940540623;5407.270018547524;5449.264349312792;5450.809221677222;4218.451601291812;4797.2564252540915;4920.803167873245;4943.2585112233455;4980.875478113004;4058.492688413948;4079.4084857695466;4198;4200.348945913388;4268.637165840876;1323.7617228898891;1342.0873805812141;1351.0610125962558;1363.9659008524866;1378.6622277541867;884.4604791077437;901.7294811556638;902.2331018634239;909.4361495872602;954.6658669465631;5961.880762384728;5986.431289027622;5989.101634754822;6187.690615469209;6367.267764207176;922.6217250927222;941.8916824565125;951.286535098676;980.6028558433703;1014.7361685961703;3913.9021524461546;3953.9604603953594;4035.4753881995152;4120.958790412117;4144.150449157915;10872.565097396173;11286.604968826216;11318.830217546743;11343.262687925258;11350.545978160946;11258.943705281421;11272.154588405738;11273.661790146309;11280.943595282135;11283.097352211804;7888.881666775003;8188.385871059575;8198.303144232807;8404.159584041668;8408.705695300636;5854.736536855767;5980.970095149496;6120.816375508742;6165.5375846810775;6211.627302361872;10084.899151008396;10556.736081598021;10645.94677026641;10647.840282395926;10656.946715266684;9903.059209375098;10131.189504839447;10292.794144117226;10407.68776936693;10624.36253824742;6810.31896810315;7449.404047676281;7554.66004029809;7931.325837303663;8067.959660201662;8250;8363.498190108612;8365.623546940524;8394.45436046655;8395.328373729964;7403.407727381689;7425.925740742523;7462.96268518654;7611.2769286917655;7611.314981651678;7159.821004474929;7279.308465695751;7407.111146662435;7536.660850261642;7663.463557550918;6468.191476065492;6579.967100164468;6583.835404114935;6590.8352291193105;6593.3736295051895;4901.362822833009;4960.429550601727;5004.0742462643075;5094.363204599425;5147.305113809588;5099.5410413063;5191.506806853494;5217.582593392443;5308.230306605444;5327.387350454593 16:29:58 INFO - PROCESS | 32130 | |4;prototype.html;334.5366667165976;334.789082877787;340.6474299100432;343.7129996452962;349.5229012398074;5088.54203121719;5156.845294641167;5338.466153384659;5393.352797664276;5417.131089774027;5164.457731938149;5189.884174902395;5195.27248194697;5249.186376111699;5249.606279529041;4153.8753837384775;4158.650362545168;4160.39674247234;4160.83356665733;4171.27002774514;3934.803259836997;4105.076357819482;4148.937765933513;4163.146554956226;4217.219814334358;4069.9214708102377;4073.5926407359175;4090.406891000803;4092.815823287959;4113.753174809521;4055.5336136344254;4076.490438695163;4095.303798354257;4098.8360465581345;4110.17796440713;3611.837467313977;3614.963850361489;3650.3976843820737;3658.9451158232646;3664.578573464059;5018.673786203885;5039.72281524516;5066.569341605968;5120.871978200537;5147.5844142861015;4688.882777930545;4690.202665546831;4698.248280275139;4710.222813235812;4711.787969541345;5397.514223719884;5402.513773760341;5403.459654034605;5439.456054394568;5443.863903402407;3814.141818090935;3932.3904794756572;3933.8167317138978;3944.408338749182;3956.1692044670654;5616.494515493625;5658.179563963244;5658.490735833753;5659.340110148265;5665.5467562594895;4019.0354314964784;4062.1875624875142;4074.124063326399;4082.591740825894;4082.6937979651643;4002.8198731057173;4115.464989551399;4115.991582062354;4127.9587204128175;4132.772697501606;4588.839390621312;4607.378003969488;4620.861374158781;4634.652401069933;4642.837500687459;5450.574494349976;5480.931218412451;5489.917651235235;5540.584456165804;5564.443555644484;1328.8538260791306;1333.8065980432782;1370.4997675848442;1395.7069015506654;1398.6223719595653;951.5147274889856;952.7808604021114;978.2516374973151;978.5694294510392;990.5344488090586;5254.185601231815;5287.68273903567;5289.3652761668845;5300.44345343741;5321;5458.208559758813;5472.781088756406;5495.598622351355;5507.807226747044;5542.279503664578;5062.848289476958;5236.345456817898;5257.4742525747115;5260.710660913686;5346.4604312951815;2950.4099180163626;2982.731554160136;2995.2926831705718;3012.231880870364;3014.216303761038;5880.794172203952;5898.557608179403;5954.553408494294;5968.1644569760265;5985.563464768425;5620.325560932714;5789.1605717171615;5796.681182535001;5799.971000145057;5813.447722466359;5863.882722345615;5876.030454974967;5880.382559831241;5895.94104058954;5987.550933679904;5396.433374495621;5657.321121465286;5684.516816070681;5760.913586296125;5769.79805706815;5592.440755924375;5623.465770751772;5628.634138780966;5655.208270842168;5657.5473962082115;5880.235569376125;5909.911351329648;5914.704264786657;5914.7338369774325;5941.673207973603;3974.701897357652;4017.8995525110936;4056.0671045659074;4078.490188726409;4091.427200192035;5414.593905457028;5694.515966142924;5735.340435849931;5756.481916627524;5759.971200143972;5397.244385786072;5550.167474878801;5577.9442205577425;5581.609287349846;5672.773089076556;5399.622026458111;5444.401115877329;5471.945280547144;5522;5543.223948647112;5256.605754568346;5428.669975855941;5445.863853403696;5455.727213639381;5484.945150548443;5449.2371068049715;5462.644928079662;5479.287692599936;5493.285872836505;5503.862403439786;5360.678359298455;5370.4629537045985;5392.325959255093;5413.918791218213;5439.347278326626 16:29:58 INFO - PROCESS | 32130 | |5;yui.html;730.5434103685196;747.1482509938671;752.5100301403221;765.0207734100352;820.6488410703337;14263.643408914782;15671.686566268681;15865;15878.126703031328;15898.12560309184;15197.4680886169;16129.516114516584;16212.75680864788;16253.106079165642;16284;669.4945316286197;806.8305655812272;825.7192554531458;825.9215374539439;826.6941231744263;788.1606089514648;807.4307613132727;807.4993504027511;807.7132617920641;814.1410811593767;852.1904191018526;852.595017366752;853.4196746212573;854.2738672128703;854.4702284583567;692.4287462843174;848.9575521223945;850.4132148817328;850.7617866997251;852.8678054901469;601.3355242457066;617.2315467243266;618.3723520626568;618.4526693875907;625.524601303013;15671.451499197474;15673.216339182994;15688.529344119695;15707.293171807296;15718.292676829456;13642.863571364358;14178.929105354511;14410.92794536031;14469.49356772508;14566.198859062748;13320.93339533296;13404.530841420601;13409.731805363936;13589.252591107484;13715;4458.509563947963;4472.127935052666;4492.146492166478;4543.727376357396;4576.0161565263625;80927.59536202281;84126.15873841244;85085.14914850834;85418.57290713569;85860;10145.391276523285;10343.120834728981;10479.528421221063;10509.684709458728;10700.625478108228;20514.692279615818;20656.690149647766;20711.792882071288;20835.58328833415;21246.893765531382;7431;7475.775726728207;7638.121616014118;7684.346830519356;8214.4660597061;4385.188740083095;4479.126570318756;4533.274676051816;4544.409226800495;4595.103954728863;3461.913452163716;3613.4941108244866;3613.6928361089604;3616.620254873253;3617.366960781853;617.3425302053299;632.6994677528229;637.2512298049772;637.7225906730587;653.4184575727606;682.2086379799409;682.754208484945;727.5889122645689;761.6306091545596;787.6731156570074;9045.638174473079;9226.76933076665;9592.95203523978;10166.847497287547;10286;617.2777849915609;647.2847503508556;675.5237557521936;683.596677960006;770.3221165374434;4638.536146385334;5059.544640982329;5069.797208111708;5093.18509038552;5149.459306772735;66632;67060.6646966762;68730.31269687338;68898;122163.38918305529;99130;102419.48790256001;102796.48601756943;102985;103037;83588;84126.15873841305;88922.55538722264;89886;91721;9661.082197191256;10244.846327304947;10388.636397726043;10460.68617941463;10701.250912436055;50374;51474.227886580986;51747.482525174266;52349.738251310024;53451.46548534465;68294;71667.64166179136;76545;77458;79515.2048479531;12419;12704.428300726304;12709.491620335082;12717.173383730027;13310.933445332712;14987.475438360041;15173.165475898932;15479;15545.533633990999;16115.838841611903;14167.504137355143;14399.78400323975;14457.27713614336;14644.414223430944;15612.141332226836;13869.167849929037;13959.581212563638;14422.495212667925;14798.260086995822;14873.92563037178;13348.866511334762;13581.93209033988;13959.441622334993;14136.929315353358;14410.135391876522;11572.768544628892;11981.64055078349;11987.940060299643;12401.535447238806;12808.103432759617;12117.15179937396;12374.195677280948;12382.504699811907;12528.436220369922;12582.685432864251 16:29:58 INFO - PROCESS | 32130 | __end_tp_report 16:29:58 INFO - PROCESS | 32130 | __start_cc_report 16:29:58 INFO - PROCESS | 32130 | _x_x_mozilla_cycle_collect,1000 16:29:58 INFO - PROCESS | 32130 | __end_cc_report 16:29:58 INFO - PROCESS | 32130 | __startTimestamp1472858998945__endTimestamp 16:29:58 INFO - PROCESS | 32130 | 16:29:58 INFO - PROCESS | 32130 | ------- Summary: start ------- 16:29:58 INFO - PROCESS | 32130 | Number of tests: 6 16:29:58 INFO - PROCESS | 32130 | 16:29:58 INFO - PROCESS | 32130 | [#0] dojo.html Cycles:165 Average:5196.97 Median:5417.59 stddev:574.27 (10.6%) stddev-sans-first:549.12 16:29:58 INFO - PROCESS | 32130 | Values: 2981.9 2985.7 3009.0 3036.1 3061.7 5032.6 5175.6 5177.1 5238.2 5279.1 5149.0 5179.8 5208.5 5249.4 5292.4 4657.7 4763.7 4783.1 4819.7 4947.2 4842.0 4866.5 4886.5 4889.4 4913.3 4624.0 4697.0 4752.8 4764.9 4785.6 4662.8 4677.5 4695.3 4749.8 4806.8 4710.7 4725.1 4729.5 4736.0 4738.8 5050.3 5068.6 5118.9 5151.3 5209.2 5461.4 5476.7 5507.3 5538.1 5543.2 5533.6 5538.1 5570.0 5591.7 5599.9 5107.4 5161.3 5191.0 5196.5 5262.0 5674.0 5680.3 5680.8 5734.4 5744.6 5451.6 5458.8 5458.9 5461.4 5462.8 5290.5 5495.4 5547.0 5557.0 5631.2 5523.9 5535.9 5537.3 5538.4 5542.5 5537.8 5541.0 5545.4 5554.7 5628.7 4224.1 4323.5 4373.0 4381.0 4425.4 3887.4 3897.3 3902.2 3944.8 3949.2 5296.8 5323.0 5343.8 5358.7 5365.5 5486.1 5593.7 5623.6 5658.0 5741.0 5341.9 5369.9 5373.9 5374.8 5378.6 4932.0 4940.5 4944.0 4946.4 4997.5 5635.0 5745.6 5763.4 5790.7 5886.6 5637.9 5638.0 5638.5 5643.6 5645.0 5795.1 5796.1 5797.8 5804.0 5811.7 5317.1 5385.6 5424.3 5433.6 5482.3 5542.5 5584.2 5594.9 5599.5 5600.0 5468.9 5475.6 5481.8 5483.4 5496.5 5368.7 5432.7 5455.1 5461.3 5585.2 5493.3 5496.6 5499.7 5499.9 5504.1 5527.1 5549.8 5554.9 5555.1 5619.7 5292.1 5347.0 5349.7 5417.6 5421.9 16:29:58 INFO - PROCESS | 32130 | 16:29:58 INFO - PROCESS | 32130 | [#1] ext.html Cycles:180 Average:61842.63 Median:42467.18 stddev:121275.16 (285.6%) stddev-sans-first:121528.04 16:29:58 INFO - PROCESS | 32130 | Values: 546.9 601.4 608.6 614.3 624.6 33325.0 34802.5 34837.7 42557.6 43452.0 45078.3 45639.1 45839.0 45955.3 46229.8 8964.3 9095.2 9102.7 9113.1 9128.2 8974.5 9060.2 9062.7 9070.6 9086.9 9087.6 9102.3 9110.0 9116.0 9124.4 9106.9 9138.5 9139.0 9143.9 9145.7 8902.5 8977.7 9017.8 9080.2 9084.5 42736.8 42790.0 43314.6 43316.8 43327.8 3432.9 3560.6 3579.8 4020.8 4232.4 30924.0 32589.3 32662.3 33013.0 34147.7 4322.5 4402.3 4414.6 4419.5 4472.3 374262.0 376015.0 376680.0 376857.0 378154.0 51825.0 61057.4 61325.7 61418.7 61431.4 63415.0 64394.7 64567.7 70606.0 70672.6 15521.3 15542.8 15555.1 15565.3 15588.8 11751.6 12533.0 12596.6 12597.0 12598.7 19015.9 19485.9 19490.2 19661.6 19792.8 7248.8 7334.9 7401.7 7490.4 7612.9 978.5 1038.8 1082.7 1128.3 1145.7 33307.7 33467.0 33474.7 33591.0 33684.0 1039.8 1088.1 1116.4 1123.5 1135.4 16567.7 17456.5 17548.7 17574.7 17611.3 556452.0 561761.0 561978.0 563048.0 563710.0 59995.0 60563.0 60581.7 60599.4 60629.7 1236.8 1335.3 1358.5 1373.8 1375.3 31684.2 33155.3 33921.3 33969.0 34556.3 49175.8 50270.2 50273.0 50276.2 50358.7 409995.0 411593.8 414618.0 416295.0 417104.0 28605.7 29651.9 29862.9 30927.4 30929.2 48693.0 48751.8 48835.8 48900.8 49313.3 41469.0 41742.0 42081.0 42267.8 43515.1 40835.0 41178.0 41531.4 42038.0 42610.6 41302.0 41899.0 42169.4 42376.8 42762.8 40100.6 41008.0 43481.0 43861.6 44061.0 32142.8 34843.8 34944.8 35060.8 35120.0 16:29:58 INFO - PROCESS | 32130 | 16:29:58 INFO - PROCESS | 32130 | [#2] jquery.html Cycles:180 Average:29115.40 Median:407.92 stddev:83979.27 (20587.3%) stddev-sans-first:84187.15 16:29:58 INFO - PROCESS | 32130 | Values: 383.5 398.1 405.9 409.9 423.3 15197.5 18651.6 18783.3 19698.7 19769.6 18062.2 18170.7 18487.0 18671.7 18709.3 5410.6 5467.9 5611.7 5707.0 5709.7 5609.8 5619.4 5624.8 5629.6 5641.0 5575.4 5613.1 5619.1 5623.0 5795.8 5899.2 5949.3 5961.0 5976.8 6010.2 5578.4 5769.7 5779.6 5822.4 5831.3 13075.4 13122.3 13400.8 13709.6 13717.4 2227.1 2309.0 2354.3 2666.3 2902.5 10776.0 11303.5 13012.0 14043.7 14770.1 1809.4 1818.4 1848.1 1871.1 1921.4 76324.6 84327.1 84940.0 85389.6 86978.0 9259.5 9609.2 9762.4 10859.7 11202.0 12489.3 13237.9 13261.8 13331.1 13342.7 7515.3 7614.3 7713.8 7925.9 7928.0 7427.9 7693.6 7745.7 7759.6 7940.2 4005.7 4015.8 4109.6 4224.0 4269.3 1964.0 1993.2 2025.9 2029.4 2035.7 867.3 960.2 968.1 1011.0 1024.4 17703.7 18447.5 18901.9 19230.0 19639.4 961.4 969.7 980.6 986.8 996.8 9990.7 10296.2 10413.9 10430.4 10502.2 505578.0 506656.0 509630.2 509728.0 511918.0 86341.0 95630.0 97439.0 98498.5 99105.5 996.6 1023.8 1040.8 1050.4 1058.2 16309.3 16497.8 16959.4 17411.7 17422.9 39881.0 40019.4 40925.4 41792.6 42227.8 55301.2 56542.4 56808.4 58418.7 59367.7 8234.0 8433.2 8442.5 8606.4 8867.5 10557.6 12674.6 12686.7 12978.2 13251.9 10716.2 10904.3 10946.6 11091.6 11213.3 5532.2 9825.7 10445.8 11125.0 11404.5 10920.9 11090.7 11128.8 11215.7 11223.8 8237.9 8318.3 8374.5 8421.2 8658.4 8982.9 11243.4 11255.2 11371.8 11559.9 16:29:58 INFO - PROCESS | 32130 | 16:29:58 INFO - PROCESS | 32130 | [#3] mootools.html Cycles:180 Average:5848.50 Median:4891.88 stddev:3345.02 (68.4%) stddev-sans-first:3337.25 16:29:58 INFO - PROCESS | 32130 | Values: 1340.7 1454.4 1505.0 1565.5 1705.8 8450.5 8844.7 8863.1 9048.7 9062.7 8850.2 8941.6 8945.8 8949.3 8964.8 2086.5 2291.2 2427.3 2439.0 2458.3 2419.8 2454.9 2456.6 2456.6 2457.7 2349.3 2353.6 2371.4 2408.9 2417.6 2019.7 2298.6 2308.8 2312.0 2393.1 2376.6 2401.5 2405.7 2406.7 2407.7 8986.6 9006.6 9025.4 9043.9 9056.2 5127.8 5234.4 5248.9 5251.4 5260.9 3281.1 3324.6 3472.7 3479.2 3479.7 1075.9 1090.3 1097.0 1102.4 1139.3 12348.8 12404.8 12444.0 12449.8 12471.4 4770.1 4792.8 4820.1 4882.4 4921.8 10434.2 10452.4 10460.5 10471.2 10476.4 5385.0 5405.9 5407.3 5449.3 5450.8 4218.5 4797.3 4920.8 4943.3 4980.9 4058.5 4079.4 4198.0 4200.3 4268.6 1323.8 1342.1 1351.1 1364.0 1378.7 884.5 901.7 902.2 909.4 954.7 5961.9 5986.4 5989.1 6187.7 6367.3 922.6 941.9 951.3 980.6 1014.7 3913.9 3954.0 4035.5 4121.0 4144.2 10872.6 11286.6 11318.8 11343.3 11350.5 11258.9 11272.2 11273.7 11280.9 11283.1 7888.9 8188.4 8198.3 8404.2 8408.7 5854.7 5981.0 6120.8 6165.5 6211.6 10084.9 10556.7 10645.9 10647.8 10656.9 9903.1 10131.2 10292.8 10407.7 10624.4 6810.3 7449.4 7554.7 7931.3 8068.0 8250.0 8363.5 8365.6 8394.5 8395.3 7403.4 7425.9 7463.0 7611.3 7611.3 7159.8 7279.3 7407.1 7536.7 7663.5 6468.2 6580.0 6583.8 6590.8 6593.4 4901.4 4960.4 5004.1 5094.4 5147.3 5099.5 5191.5 5217.6 5308.2 5327.4 16:29:58 INFO - PROCESS | 32130 | 16:29:58 INFO - PROCESS | 32130 | [#4] prototype.html Cycles:180 Average:4643.09 Median:5310.72 stddev:1363.76 (25.7%) stddev-sans-first:1328.69 16:29:58 INFO - PROCESS | 32130 | Values: 334.5 334.8 340.6 343.7 349.5 5088.5 5156.8 5338.5 5393.4 5417.1 5164.5 5189.9 5195.3 5249.2 5249.6 4153.9 4158.7 4160.4 4160.8 4171.3 3934.8 4105.1 4148.9 4163.1 4217.2 4069.9 4073.6 4090.4 4092.8 4113.8 4055.5 4076.5 4095.3 4098.8 4110.2 3611.8 3615.0 3650.4 3658.9 3664.6 5018.7 5039.7 5066.6 5120.9 5147.6 4688.9 4690.2 4698.2 4710.2 4711.8 5397.5 5402.5 5403.5 5439.5 5443.9 3814.1 3932.4 3933.8 3944.4 3956.2 5616.5 5658.2 5658.5 5659.3 5665.5 4019.0 4062.2 4074.1 4082.6 4082.7 4002.8 4115.5 4116.0 4128.0 4132.8 4588.8 4607.4 4620.9 4634.7 4642.8 5450.6 5480.9 5489.9 5540.6 5564.4 1328.9 1333.8 1370.5 1395.7 1398.6 951.5 952.8 978.3 978.6 990.5 5254.2 5287.7 5289.4 5300.4 5321.0 5458.2 5472.8 5495.6 5507.8 5542.3 5062.8 5236.3 5257.5 5260.7 5346.5 2950.4 2982.7 2995.3 3012.2 3014.2 5880.8 5898.6 5954.6 5968.2 5985.6 5620.3 5789.2 5796.7 5800.0 5813.4 5863.9 5876.0 5880.4 5895.9 5987.6 5396.4 5657.3 5684.5 5760.9 5769.8 5592.4 5623.5 5628.6 5655.2 5657.5 5880.2 5909.9 5914.7 5914.7 5941.7 3974.7 4017.9 4056.1 4078.5 4091.4 5414.6 5694.5 5735.3 5756.5 5760.0 5397.2 5550.2 5577.9 5581.6 5672.8 5399.6 5444.4 5471.9 5522.0 5543.2 5256.6 5428.7 5445.9 5455.7 5484.9 5449.2 5462.6 5479.3 5493.3 5503.9 5360.7 5370.5 5392.3 5413.9 5439.3 16:29:58 INFO - PROCESS | 32130 | 16:29:58 INFO - PROCESS | 32130 | [#5] yui.html Cycles:180 Average:20364.33 Median:4512.71 stddev:28253.98 (626.1%) stddev-sans-first:28294.78 16:29:58 INFO - PROCESS | 32130 | Values: 730.5 747.1 752.5 765.0 820.6 14263.6 15671.7 15865.0 15878.1 15898.1 15197.5 16129.5 16212.8 16253.1 16284.0 669.5 806.8 825.7 825.9 826.7 788.2 807.4 807.5 807.7 814.1 852.2 852.6 853.4 854.3 854.5 692.4 849.0 850.4 850.8 852.9 601.3 617.2 618.4 618.5 625.5 15671.5 15673.2 15688.5 15707.3 15718.3 13642.9 14178.9 14410.9 14469.5 14566.2 13320.9 13404.5 13409.7 13589.3 13715.0 4458.5 4472.1 4492.1 4543.7 4576.0 80927.6 84126.2 85085.1 85418.6 85860.0 10145.4 10343.1 10479.5 10509.7 10700.6 20514.7 20656.7 20711.8 20835.6 21246.9 7431.0 7475.8 7638.1 7684.3 8214.5 4385.2 4479.1 4533.3 4544.4 4595.1 3461.9 3613.5 3613.7 3616.6 3617.4 617.3 632.7 637.3 637.7 653.4 682.2 682.8 727.6 761.6 787.7 9045.6 9226.8 9593.0 10166.8 10286.0 617.3 647.3 675.5 683.6 770.3 4638.5 5059.5 5069.8 5093.2 5149.5 66632.0 67060.7 68730.3 68898.0 122163.4 99130.0 102419.5 102796.5 102985.0 103037.0 83588.0 84126.2 88922.6 89886.0 91721.0 9661.1 10244.8 10388.6 10460.7 10701.3 50374.0 51474.2 51747.5 52349.7 53451.5 68294.0 71667.6 76545.0 77458.0 79515.2 12419.0 12704.4 12709.5 12717.2 13310.9 14987.5 15173.2 15479.0 15545.5 16115.8 14167.5 14399.8 14457.3 14644.4 15612.1 13869.2 13959.6 14422.5 14798.3 14873.9 13348.9 13581.9 13959.4 14136.9 14410.1 11572.8 11981.6 11987.9 12401.5 12808.1 12117.2 12374.2 12382.5 12528.4 12582.7 16:29:58 INFO - PROCESS | 32130 | -------- Summary: end -------- 16:29:58 INFO - PROCESS | 32130 | 16:29:59 INFO - TEST-INFO | 32130: exit 0 16:29:59 INFO - TEST-OK | dromaeo_css | took 1115222ms 16:29:59 INFO - TEST-START | kraken 16:29:59 INFO - operating with platform_type : linux_ 16:29:59 INFO - Initialising browser for kraken test... 16:29:59 INFO - TEST-INFO | started process 32436 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiB5abN/profile http://localhost:54597/getInfo.html) 16:30:03 INFO - PROCESS | 32436 | __metrics Screen width/height:1600/1200 16:30:03 INFO - PROCESS | 32436 | colorDepth:24 16:30:03 INFO - PROCESS | 32436 | Browser inner width/height: 1024/697 16:30:03 INFO - PROCESS | 32436 | __metrics 16:30:04 INFO - PROCESS | 32436 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:30:04 INFO - PROCESS | 32436 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:30:04 INFO - PROCESS | 32436 | console.error: PushService: 16:30:04 INFO - PROCESS | 32436 | stateChangeProcessEnqueue: Error transitioning state 16:30:04 INFO - PROCESS | 32436 | UnknownError 16:30:05 INFO - TEST-INFO | 32436: exit 0 16:30:05 INFO - Browser initialized. 16:30:05 INFO - Running cycle 1/1 for kraken test... 16:30:05 INFO - TEST-INFO | started process 32519 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiB5abN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:30:17 INFO - PROCESS | 32519 | RSS: Main: 179093504 16:30:17 INFO - PROCESS | 32519 | 16:30:20 INFO - PROCESS | 32519 | Cycle 1(1): loaded http://localhost:54597/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54597/tests/kraken/driver.html?testName=audio-beat-detection) 16:30:20 INFO - PROCESS | 32519 | RSS: Main: 233697280 16:30:20 INFO - PROCESS | 32519 | 16:30:23 INFO - PROCESS | 32519 | Cycle 1(1): loaded http://localhost:54597/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54597/tests/kraken/driver.html?testName=audio-dft) 16:30:24 INFO - PROCESS | 32519 | RSS: Main: 223895552 16:30:24 INFO - PROCESS | 32519 | 16:30:27 INFO - PROCESS | 32519 | Cycle 1(1): loaded http://localhost:54597/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54597/tests/kraken/driver.html?testName=audio-fft) 16:30:27 INFO - PROCESS | 32519 | RSS: Main: 301514752 16:30:27 INFO - PROCESS | 32519 | 16:30:29 INFO - PROCESS | 32519 | Cycle 1(1): loaded http://localhost:54597/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54597/tests/kraken/driver.html?testName=audio-oscillator) 16:30:30 INFO - PROCESS | 32519 | RSS: Main: 212070400 16:30:30 INFO - PROCESS | 32519 | 16:30:32 INFO - PROCESS | 32519 | Cycle 1(1): loaded http://localhost:54597/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54597/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:30:33 INFO - PROCESS | 32519 | RSS: Main: 214110208 16:30:33 INFO - PROCESS | 32519 | 16:30:36 INFO - PROCESS | 32519 | Cycle 1(1): loaded http://localhost:54597/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54597/tests/kraken/driver.html?testName=imaging-darkroom) 16:30:36 INFO - PROCESS | 32519 | RSS: Main: 251822080 16:30:36 INFO - PROCESS | 32519 | 16:30:40 INFO - PROCESS | 32519 | Cycle 1(1): loaded http://localhost:54597/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54597/tests/kraken/driver.html?testName=imaging-desaturate) 16:30:40 INFO - PROCESS | 32519 | RSS: Main: 250851328 16:30:40 INFO - PROCESS | 32519 | 16:30:43 INFO - PROCESS | 32519 | Cycle 1(1): loaded http://localhost:54597/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54597/tests/kraken/driver.html?testName=json-parse-financial) 16:30:44 INFO - PROCESS | 32519 | RSS: Main: 251088896 16:30:44 INFO - PROCESS | 32519 | 16:30:45 INFO - PROCESS | 32519 | Cycle 1(1): loaded http://localhost:54597/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54597/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:30:46 INFO - PROCESS | 32519 | RSS: Main: 214142976 16:30:46 INFO - PROCESS | 32519 | 16:30:48 INFO - PROCESS | 32519 | Cycle 1(1): loaded http://localhost:54597/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54597/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:30:48 INFO - PROCESS | 32519 | RSS: Main: 222097408 16:30:48 INFO - PROCESS | 32519 | 16:30:50 INFO - PROCESS | 32519 | Cycle 1(1): loaded http://localhost:54597/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54597/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:30:51 INFO - PROCESS | 32519 | RSS: Main: 222195712 16:30:51 INFO - PROCESS | 32519 | 16:30:54 INFO - PROCESS | 32519 | Cycle 1(1): loaded http://localhost:54597/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:30:54 INFO - PROCESS | 32519 | RSS: Main: 223469568 16:30:54 INFO - PROCESS | 32519 | 16:30:57 INFO - PROCESS | 32519 | Cycle 1(1): loaded http://localhost:54597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:30:58 INFO - PROCESS | 32519 | RSS: Main: 221417472 16:30:58 INFO - PROCESS | 32519 | 16:30:59 INFO - PROCESS | 32519 | Cycle 1(1): loaded http://localhost:54597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54597/tests/kraken/driver.html?testName=ai-astar) 16:31:00 INFO - PROCESS | 32519 | RSS: Main: 272642048 16:31:00 INFO - PROCESS | 32519 | 16:31:00 INFO - PROCESS | 32519 | __start_tp_report 16:31:00 INFO - PROCESS | 32519 | _x_x_mozilla_page_load 16:31:00 INFO - PROCESS | 32519 | _x_x_mozilla_page_load_details 16:31:00 INFO - PROCESS | 32519 | |i|pagename|runs| 16:31:00 INFO - PROCESS | 32519 | |0;ai-astar;113;112;118;113;114;114;111;112;112;129 16:31:00 INFO - PROCESS | 32519 | |1;audio-beat-detection;145;117;145;175;119;144;147;118;172;117 16:31:00 INFO - PROCESS | 32519 | |2;audio-dft;161;162;162;162;162;164;163;164;161;165 16:31:00 INFO - PROCESS | 32519 | |3;audio-fft;76;76;77;171;78;77;76;76;159;75 16:31:00 INFO - PROCESS | 32519 | |4;audio-oscillator;84;83;140;83;83;84;149;83;83;143 16:31:00 INFO - PROCESS | 32519 | |5;imaging-gaussian-blur;117;117;116;117;118;117;118;117;119;117 16:31:00 INFO - PROCESS | 32519 | |6;imaging-darkroom;147;146;146;146;146;147;146;147;146;146 16:31:00 INFO - PROCESS | 32519 | |7;imaging-desaturate;95;95;95;96;95;95;95;96;95;95 16:31:00 INFO - PROCESS | 32519 | |8;json-parse-financial;55;53;54;54;53;54;53;55;53;53 16:31:00 INFO - PROCESS | 32519 | |9;json-stringify-tinderbox;62;63;61;62;61;61;61;62;62;64 16:31:00 INFO - PROCESS | 32519 | |10;stanford-crypto-aes;81;78;82;80;78;79;80;78;89;79 16:31:00 INFO - PROCESS | 32519 | |11;stanford-crypto-ccm;138;125;137;129;139;126;134;126;183;137 16:31:00 INFO - PROCESS | 32519 | |12;stanford-crypto-pbkdf2;168;170;167;169;170;166;166;164;169;164 16:31:00 INFO - PROCESS | 32519 | |13;stanford-crypto-sha256-iterative;71;66;67;66;69;66;74;66;66;65 16:31:00 INFO - PROCESS | 32519 | __end_tp_report 16:31:00 INFO - PROCESS | 32519 | __start_cc_report 16:31:00 INFO - PROCESS | 32519 | _x_x_mozilla_cycle_collect,1691 16:31:00 INFO - PROCESS | 32519 | __end_cc_report 16:31:00 INFO - PROCESS | 32519 | __startTimestamp1472859060145__endTimestamp 16:31:00 INFO - PROCESS | 32519 | 16:31:00 INFO - PROCESS | 32519 | ------- Summary: start ------- 16:31:00 INFO - PROCESS | 32519 | Number of tests: 14 16:31:00 INFO - PROCESS | 32519 | 16:31:00 INFO - PROCESS | 32519 | [#0] ai-astar Cycles:10 Average:114.80 Median:113.50 stddev:5.35 (4.7%) stddev-sans-first:5.63 16:31:00 INFO - PROCESS | 32519 | Values: 113.0 112.0 118.0 113.0 114.0 114.0 111.0 112.0 112.0 129.0 16:31:00 INFO - PROCESS | 32519 | 16:31:00 INFO - PROCESS | 32519 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:145.00 stddev:21.98 (15.2%) stddev-sans-first:23.23 16:31:00 INFO - PROCESS | 32519 | Values: 145.0 117.0 145.0 175.0 119.0 144.0 147.0 118.0 172.0 117.0 16:31:00 INFO - PROCESS | 32519 | 16:31:00 INFO - PROCESS | 32519 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.50 stddev:1.35 (0.8%) stddev-sans-first:1.30 16:31:00 INFO - PROCESS | 32519 | Values: 161.0 162.0 162.0 162.0 162.0 164.0 163.0 164.0 161.0 165.0 16:31:00 INFO - PROCESS | 32519 | 16:31:00 INFO - PROCESS | 32519 | [#3] audio-fft Cycles:10 Average:94.10 Median:76.00 stddev:37.48 (49.3%) stddev-sans-first:39.18 16:31:00 INFO - PROCESS | 32519 | Values: 76.0 76.0 77.0 171.0 78.0 77.0 76.0 76.0 159.0 75.0 16:31:00 INFO - PROCESS | 32519 | 16:31:00 INFO - PROCESS | 32519 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:83.00 stddev:29.41 (35.4%) stddev-sans-first:30.50 16:31:00 INFO - PROCESS | 32519 | Values: 84.0 83.0 140.0 83.0 83.0 84.0 149.0 83.0 83.0 143.0 16:31:00 INFO - PROCESS | 32519 | 16:31:00 INFO - PROCESS | 32519 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 16:31:00 INFO - PROCESS | 32519 | Values: 117.0 117.0 116.0 117.0 118.0 117.0 118.0 117.0 119.0 117.0 16:31:00 INFO - PROCESS | 32519 | 16:31:00 INFO - PROCESS | 32519 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 16:31:00 INFO - PROCESS | 32519 | Values: 147.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 16:31:00 INFO - PROCESS | 32519 | 16:31:00 INFO - PROCESS | 32519 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:31:00 INFO - PROCESS | 32519 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 16:31:00 INFO - PROCESS | 32519 | 16:31:00 INFO - PROCESS | 32519 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.73 16:31:00 INFO - PROCESS | 32519 | Values: 55.0 53.0 54.0 54.0 53.0 54.0 53.0 55.0 53.0 53.0 16:31:00 INFO - PROCESS | 32519 | 16:31:00 INFO - PROCESS | 32519 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 16:31:00 INFO - PROCESS | 32519 | Values: 62.0 63.0 61.0 62.0 61.0 61.0 61.0 62.0 62.0 64.0 16:31:00 INFO - PROCESS | 32519 | 16:31:00 INFO - PROCESS | 32519 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:3.31 (4.1%) stddev-sans-first:3.50 16:31:00 INFO - PROCESS | 32519 | Values: 81.0 78.0 82.0 80.0 78.0 79.0 80.0 78.0 89.0 79.0 16:31:00 INFO - PROCESS | 32519 | 16:31:00 INFO - PROCESS | 32519 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:137.00 stddev:16.93 (12.4%) stddev-sans-first:17.95 16:31:00 INFO - PROCESS | 32519 | Values: 138.0 125.0 137.0 129.0 139.0 126.0 134.0 126.0 183.0 137.0 16:31:00 INFO - PROCESS | 32519 | 16:31:00 INFO - PROCESS | 32519 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:168.50 stddev:2.26 (1.3%) stddev-sans-first:2.39 16:31:00 INFO - PROCESS | 32519 | Values: 168.0 170.0 167.0 169.0 170.0 166.0 166.0 164.0 169.0 164.0 16:31:00 INFO - PROCESS | 32519 | 16:31:00 INFO - PROCESS | 32519 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:66.50 stddev:2.88 (4.3%) stddev-sans-first:2.77 16:31:00 INFO - PROCESS | 32519 | Values: 71.0 66.0 67.0 66.0 69.0 66.0 74.0 66.0 66.0 65.0 16:31:00 INFO - PROCESS | 32519 | -------- Summary: end -------- 16:31:00 INFO - PROCESS | 32519 | 16:31:01 INFO - TEST-INFO | 32519: exit 0 16:31:01 INFO - TEST-OK | kraken | took 61486ms 16:31:01 INFO - SUITE-END | took 1176s 16:31:01 INFO - Completed test suite (00:19:37) 16:31:01 INFO - javascript benchmark 16:31:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2981.865816038278, 2985.6715761266255, 3008.9548656770153, 3036.1347016100417, 3061.7244447999674, 5032.572231360339, 5175.637705360627, 5177.068127737006, 5238.18808084747, 5279.128943724286, 5148.974255128728, 5179.8446046618665, 5208.453112423188, 5249.370075590934, 5292.444293349201, 4657.720536767788, 4763.666543341968, 4783.139034973703, 4819.6867203631655, 4947.1589829728855, 4841.951580484185, 4866.51334866514, 4886.48691887352, 4889.437714662824, 4913.336699545552, 4623.976880115595, 4697.037107392976, 4752.7861246244, 4764.928526072112, 4785.617150627959, 4662.790174442158, 4677.50886156952, 4695.272232803921, 4749.833755818564, 4806.759662016885, 4710.693804902705, 4725.054989002213, 4729.527047295277, 4735.976320118411, 4738.83414080509, 5050.318207042076, 5068.619853511002, 5118.923216151761, 5151.304573882516, 5209.218617207412, 5461.42655021225, 5476.67139971603, 5507.339119305669, 5538.086215774392, 5543.196236545678, 5533.584981126432, 5538.141588053818, 5569.969555632221, 5591.692456914868, 5599.877338846486, 5107.361579802525, 5161.277421161003, 5191.0, 5196.506331898426, 5261.973690131525, 5674.035413979551, 5680.346760122557, 5680.801171958961, 5734.426557344233, 5744.569157313134, 5451.591130665216, 5458.781648734006, 5458.935507576064, 5461.399246082928, 5462.808801691922, 5290.523852853262, 5495.395506494282, 5547.0, 5557.0, 5631.239782629293, 5523.944760552424, 5535.889282214333, 5537.252470916455, 5538.390777014525, 5542.528885044816, 5537.778488860481, 5540.972295138579, 5545.390007099216, 5554.666719996732, 5628.71856407178, 4224.070704445017, 4323.459567554056, 4372.956270437318, 4381.036172042146, 4425.424694789656, 3887.4168874669026, 3897.2595206910596, 3902.20004898995, 3944.7633142010995, 3949.190415964778, 5296.788128474818, 5322.973385133127, 5343.770932685504, 5358.732063396815, 5365.490278423544, 5486.1222204447095, 5593.664380137205, 5623.634463759842, 5658.0, 5741.0, 5341.919871201935, 5369.865753356197, 5373.925214956946, 5374.758135883894, 5378.596605254622, 4931.975340123348, 4940.530649588283, 4943.950560494349, 4946.406431228275, 4997.5002499749735, 5635.042042852725, 5745.569082318842, 5763.394843541451, 5790.652560846363, 5886.6173698709445, 5637.8590535236945, 5638.041532939328, 5638.4925356718095, 5643.576731745054, 5644.971775141098, 5795.072788353843, 5796.1305804129715, 5797.797077102281, 5804.042333015174, 5811.651300921958, 5317.1492561190025, 5385.596080293915, 5424.267723857229, 5433.619646624857, 5482.314710661168, 5542.501174894279, 5584.162375643686, 5594.944050559442, 5599.496045355938, 5600.047991841316, 5468.945310547003, 5475.561955043508, 5481.75332110048, 5483.424240454695, 5496.450354964471, 5368.731563421735, 5432.674039557639, 5455.1271796512365, 5461.317335333083, 5585.162225666182, 5493.340799104133, 5496.587755918402, 5499.670019798825, 5499.917501237404, 5504.146857237135, 5527.088030474926, 5549.833504994856, 5554.888902221852, 5555.0834112371, 5619.662820230799, 5292.126799078109, 5347.0, 5349.705766182898, 5417.593680473901, 5421.864453388697], "value": 5159.0609474192315, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.9219626122176, 601.4136217188242, 608.6226539545481, 614.2536817766415, 624.5534442873345, 33325.0, 34802.47796283058, 34837.651623483755, 42557.57442425575, 43452.0, 45078.32382514265, 45639.08721825561, 45839.0, 45955.31067033997, 46229.76885115578, 8964.282857371394, 9095.226905713022, 9102.726918192431, 9113.134252246025, 9128.224100951395, 8974.50640214788, 9060.184583387494, 9062.682806101788, 9070.591823367964, 9086.86369704455, 9087.591058402388, 9102.271818254558, 9109.99790023097, 9116.0, 9124.361294709373, 9106.863397049017, 9138.497382643953, 9139.0, 9143.908560914406, 9145.679901203492, 8902.510361930092, 8977.685780997634, 9017.819643607158, 9080.22818060459, 9084.50035248061, 42736.78631606853, 42790.0, 43314.566854331366, 43316.78341608303, 43327.78336108331, 3432.8970130896114, 3560.6439356064448, 3579.83890724918, 4020.7587544747407, 4232.365145228209, 30924.0, 32589.348213035606, 32662.346753065045, 33013.0, 34147.6585234147, 4322.459692538433, 4402.3176407656865, 4414.624756895668, 4419.469663640351, 4472.306792447176, 374262.0, 376015.0, 376680.0, 376857.0, 378154.0, 51825.0, 61057.389426106056, 61325.69337153375, 61418.69290653518, 61431.38568614257, 63415.0, 64394.678026610505, 64567.677161613894, 70606.0, 70672.64663676752, 15521.301541430663, 15542.766858497132, 15555.144467054195, 15565.29956151976, 15588.766168507482, 11751.588694395656, 12533.0, 12596.55912043074, 12597.0, 12598.748025039447, 19015.904920475587, 19485.90257048706, 19490.220391184193, 19661.606767864563, 19792.802071979382, 7248.782536523912, 7334.926650733424, 7401.740939067106, 7490.363319117936, 7612.885806712904, 978.4862946952907, 1038.8441733739999, 1082.6643740440488, 1128.2779021426293, 1145.73075327298, 33307.666923330944, 33467.0, 33474.66525334716, 33591.0, 33684.0, 1039.8180318444242, 1088.1458055426451, 1116.436199719153, 1123.4775829239443, 1135.437958210691, 16567.668646627, 17456.47630571085, 17548.736768948474, 17574.736378954327, 17611.295548177928, 556452.0, 561761.0, 561978.0, 563048.0, 563710.0, 59995.0, 60563.0, 60581.69709151514, 60599.394006060254, 60629.69685151546, 1236.8330275412704, 1335.2989680417859, 1358.4634069542674, 1373.7870630052157, 1375.2848518770184, 31684.207894802814, 33155.33689326248, 33921.32157356889, 33969.0, 34556.30887382288, 49175.75412122916, 50270.24594631157, 50273.0, 50276.245856311456, 50358.74820625874, 409995.0, 411593.84061593603, 414618.0, 416295.0, 417104.0, 28605.713942860304, 29651.851740742022, 29862.85068574643, 30927.381452371275, 30929.20597307421, 48693.0, 48751.806168721785, 48835.755821220664, 48900.75549622229, 49313.26030109479, 41469.0, 41742.0, 42081.0, 42267.7886610565, 43515.12969740524, 40835.0, 41178.0, 41531.37702934398, 42038.0, 42610.57389426066, 41302.0, 41899.0, 42169.36745948875, 42376.78811606046, 42762.78618606887, 40100.598994009684, 41008.0, 43481.0, 43861.56138438575, 44061.0, 32142.83928580342, 34843.82578087093, 34944.82527587346, 35060.824695877374, 35120.0], "value": 20642.050978877814, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.54549858417795, 398.09433538699454, 405.8924385037964, 409.94260803487515, 423.3353634793374, 15197.544073677793, 18651.62696746064, 18783.3425830096, 19698.70451943222, 19769.604607907833, 18062.18720157593, 18170.727439088423, 18487.0, 18671.71992420115, 18709.34517291892, 5410.648307859996, 5467.917981230285, 5611.691356975365, 5707.0, 5709.71451427429, 5609.775608975636, 5619.438056194368, 5624.831255062355, 5629.6340737852115, 5641.0, 5575.358833734132, 5613.101903695409, 5619.129034999582, 5623.0, 5795.82612521625, 5899.203607512974, 5949.25634295713, 5960.970195148997, 5976.7908123215475, 6010.248718910137, 5578.386377498472, 5769.740361683735, 5779.595428320019, 5822.359540450547, 5831.271091113611, 13075.411606477732, 13122.278274694889, 13400.79898801509, 13709.588712338646, 13717.382717777624, 2227.12028748645, 2309.0, 2354.329016230366, 2666.266776636421, 2902.4630443368046, 10776.0, 11303.491342889589, 13012.0, 14043.719125617532, 14770.113793172444, 1809.3576780242956, 1818.354484158118, 1848.0944337274773, 1871.0925201277369, 1921.3563456242036, 76324.61837690831, 84327.0971032028, 84940.0, 85389.57305213434, 86978.0, 9259.490728009889, 9609.183219426428, 9762.414255144571, 10859.674209773719, 11202.047825934724, 12489.250644961332, 13237.867621323663, 13261.801072983913, 13331.133476324008, 13342.733145337039, 7515.286047825448, 7614.314711675865, 7713.7685869424, 7925.920740792633, 7927.960360198162, 7427.851442971219, 7693.615319234016, 7745.690172393154, 7759.612019399007, 7940.205979402013, 4005.6595189409227, 4015.799210039545, 4109.589041095926, 4223.957760422357, 4269.295566231537, 1963.9509012274807, 1993.2226431691652, 2025.8885761282977, 2029.3911826452006, 2035.714999900015, 867.3321542412307, 960.188640598693, 968.138356862393, 1011.0041609015115, 1024.3546565663585, 17703.73444398335, 18447.53881152982, 18901.905490472458, 19230.03849807504, 19639.410817675493, 961.3895176562933, 969.6896992962185, 980.578351308944, 986.7582442301539, 996.8056229035268, 9990.650327238513, 10296.22778291631, 10413.895861041445, 10430.37417754922, 10502.212334074975, 505578.0, 506656.0, 509630.2295816326, 509728.0, 511918.0, 86341.0, 95630.0, 97439.025609743, 98498.50750746201, 99105.50447247717, 996.6063404955147, 1023.7696518283327, 1040.7710303733168, 1050.3592808386877, 1058.1904842795268, 16309.347626094823, 16497.752533712242, 16959.406420775213, 17411.651766964842, 17422.912885436, 39881.0, 40019.3997090038, 40925.386119207644, 41792.58207417887, 42227.788861056724, 55301.170482441994, 56542.43457565536, 56808.43191568032, 58418.70790646019, 59367.703161485646, 8234.0, 8433.19884610961, 8442.493450392996, 8606.44058136219, 8867.512286824287, 10557.63048293306, 12674.619761407173, 12686.746265074831, 12978.156419832681, 13251.86748132545, 10716.249862509549, 10904.34573925567, 10946.616868409568, 11091.611793587186, 11213.271137376045, 5532.2254884317035, 9825.705228843146, 10445.843312350169, 11125.0, 11404.48679809394, 10920.890791091988, 11090.667279981613, 11128.833067504156, 11215.66353009411, 11223.831642525533, 8237.876431853407, 8318.334533237448, 8374.53940033304, 8421.157884211774, 8658.350623703122, 8982.86525702128, 11243.4378281084, 11255.212135150461, 11371.772564548828, 11559.884401155881], "value": 8903.040958873213, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.6648337915522, 1454.4182327069175, 1504.969900601988, 1565.4833904811414, 1705.7611934329204, 8450.492970421772, 8844.690435834747, 8863.069377715343, 9048.683296084639, 9062.728118156449, 8850.159234872694, 8941.64233430662, 8945.776355591113, 8949.328800339985, 8964.820703585925, 2086.488810241493, 2291.163725240292, 2427.296084135603, 2438.9878050609723, 2458.2870967419426, 2419.758024197584, 2454.9386265343333, 2456.570100232452, 2456.6069428891383, 2457.680501534798, 2349.2717257650097, 2353.635186546088, 2371.4071482129466, 2408.9280270279733, 2417.613181890898, 2019.6667549854403, 2298.5632729781287, 2308.826837987158, 2311.9537609247723, 2393.066703985447, 2376.560336337783, 2401.4956859059616, 2405.687260656121, 2406.651035599828, 2407.6749638798715, 8986.55067246635, 9006.639734410615, 9025.368224224307, 9043.864342034874, 9056.184943355063, 5127.769250383742, 5234.42421333653, 5248.947510524884, 5251.369835619712, 5260.8684782880355, 3281.1305004173914, 3324.6176689680756, 3472.722182225441, 3479.182392137871, 3479.704225140866, 1075.8924107589257, 1090.3076546393017, 1096.9524104480201, 1102.3881745631172, 1139.2651739627977, 12348.814767778491, 12404.75190496185, 12444.0, 12449.75100497994, 12471.438785254686, 4770.0936822003705, 4792.808287668524, 4820.132376172322, 4882.389701287339, 4921.827736029293, 10434.21743369235, 10452.425116618659, 10460.476976151162, 10471.214658900613, 10476.371417714961, 5384.9730751346, 5405.945940540623, 5407.270018547524, 5449.264349312792, 5450.809221677222, 4218.451601291812, 4797.2564252540915, 4920.803167873245, 4943.2585112233455, 4980.875478113004, 4058.492688413948, 4079.4084857695466, 4198.0, 4200.348945913388, 4268.637165840876, 1323.7617228898891, 1342.0873805812141, 1351.0610125962558, 1363.9659008524866, 1378.6622277541867, 884.4604791077437, 901.7294811556638, 902.2331018634239, 909.4361495872602, 954.6658669465631, 5961.880762384728, 5986.431289027622, 5989.101634754822, 6187.690615469209, 6367.267764207176, 922.6217250927222, 941.8916824565125, 951.286535098676, 980.6028558433703, 1014.7361685961703, 3913.9021524461546, 3953.9604603953594, 4035.4753881995152, 4120.958790412117, 4144.150449157915, 10872.565097396173, 11286.604968826216, 11318.830217546743, 11343.262687925258, 11350.545978160946, 11258.943705281421, 11272.154588405738, 11273.661790146309, 11280.943595282135, 11283.097352211804, 7888.881666775003, 8188.385871059575, 8198.303144232807, 8404.159584041668, 8408.705695300636, 5854.736536855767, 5980.970095149496, 6120.816375508742, 6165.5375846810775, 6211.627302361872, 10084.899151008396, 10556.736081598021, 10645.94677026641, 10647.840282395926, 10656.946715266684, 9903.059209375098, 10131.189504839447, 10292.794144117226, 10407.68776936693, 10624.36253824742, 6810.31896810315, 7449.404047676281, 7554.66004029809, 7931.325837303663, 8067.959660201662, 8250.0, 8363.498190108612, 8365.623546940524, 8394.45436046655, 8395.328373729964, 7403.407727381689, 7425.925740742523, 7462.96268518654, 7611.2769286917655, 7611.314981651678, 7159.821004474929, 7279.308465695751, 7407.111146662435, 7536.660850261642, 7663.463557550918, 6468.191476065492, 6579.967100164468, 6583.835404114935, 6590.8352291193105, 6593.3736295051895, 4901.362822833009, 4960.429550601727, 5004.0742462643075, 5094.363204599425, 5147.305113809588, 5099.5410413063, 5191.506806853494, 5217.582593392443, 5308.230306605444, 5327.387350454593], "value": 4673.761353693457, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.5366667165976, 334.789082877787, 340.6474299100432, 343.7129996452962, 349.5229012398074, 5088.54203121719, 5156.845294641167, 5338.466153384659, 5393.352797664276, 5417.131089774027, 5164.457731938149, 5189.884174902395, 5195.27248194697, 5249.186376111699, 5249.606279529041, 4153.8753837384775, 4158.650362545168, 4160.39674247234, 4160.83356665733, 4171.27002774514, 3934.803259836997, 4105.076357819482, 4148.937765933513, 4163.146554956226, 4217.219814334358, 4069.9214708102377, 4073.5926407359175, 4090.406891000803, 4092.815823287959, 4113.753174809521, 4055.5336136344254, 4076.490438695163, 4095.303798354257, 4098.8360465581345, 4110.17796440713, 3611.837467313977, 3614.963850361489, 3650.3976843820737, 3658.9451158232646, 3664.578573464059, 5018.673786203885, 5039.72281524516, 5066.569341605968, 5120.871978200537, 5147.5844142861015, 4688.882777930545, 4690.202665546831, 4698.248280275139, 4710.222813235812, 4711.787969541345, 5397.514223719884, 5402.513773760341, 5403.459654034605, 5439.456054394568, 5443.863903402407, 3814.141818090935, 3932.3904794756572, 3933.8167317138978, 3944.408338749182, 3956.1692044670654, 5616.494515493625, 5658.179563963244, 5658.490735833753, 5659.340110148265, 5665.5467562594895, 4019.0354314964784, 4062.1875624875142, 4074.124063326399, 4082.591740825894, 4082.6937979651643, 4002.8198731057173, 4115.464989551399, 4115.991582062354, 4127.9587204128175, 4132.772697501606, 4588.839390621312, 4607.378003969488, 4620.861374158781, 4634.652401069933, 4642.837500687459, 5450.574494349976, 5480.931218412451, 5489.917651235235, 5540.584456165804, 5564.443555644484, 1328.8538260791306, 1333.8065980432782, 1370.4997675848442, 1395.7069015506654, 1398.6223719595653, 951.5147274889856, 952.7808604021114, 978.2516374973151, 978.5694294510392, 990.5344488090586, 5254.185601231815, 5287.68273903567, 5289.3652761668845, 5300.44345343741, 5321.0, 5458.208559758813, 5472.781088756406, 5495.598622351355, 5507.807226747044, 5542.279503664578, 5062.848289476958, 5236.345456817898, 5257.4742525747115, 5260.710660913686, 5346.4604312951815, 2950.4099180163626, 2982.731554160136, 2995.2926831705718, 3012.231880870364, 3014.216303761038, 5880.794172203952, 5898.557608179403, 5954.553408494294, 5968.1644569760265, 5985.563464768425, 5620.325560932714, 5789.1605717171615, 5796.681182535001, 5799.971000145057, 5813.447722466359, 5863.882722345615, 5876.030454974967, 5880.382559831241, 5895.94104058954, 5987.550933679904, 5396.433374495621, 5657.321121465286, 5684.516816070681, 5760.913586296125, 5769.79805706815, 5592.440755924375, 5623.465770751772, 5628.634138780966, 5655.208270842168, 5657.5473962082115, 5880.235569376125, 5909.911351329648, 5914.704264786657, 5914.7338369774325, 5941.673207973603, 3974.701897357652, 4017.8995525110936, 4056.0671045659074, 4078.490188726409, 4091.427200192035, 5414.593905457028, 5694.515966142924, 5735.340435849931, 5756.481916627524, 5759.971200143972, 5397.244385786072, 5550.167474878801, 5577.9442205577425, 5581.609287349846, 5672.773089076556, 5399.622026458111, 5444.401115877329, 5471.945280547144, 5522.0, 5543.223948647112, 5256.605754568346, 5428.669975855941, 5445.863853403696, 5455.727213639381, 5484.945150548443, 5449.2371068049715, 5462.644928079662, 5479.287692599936, 5493.285872836505, 5503.862403439786, 5360.678359298455, 5370.4629537045985, 5392.325959255093, 5413.918791218213, 5439.347278326626], "value": 4212.168653081605, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.5434103685196, 747.1482509938671, 752.5100301403221, 765.0207734100352, 820.6488410703337, 14263.643408914782, 15671.686566268681, 15865.0, 15878.126703031328, 15898.12560309184, 15197.4680886169, 16129.516114516584, 16212.75680864788, 16253.106079165642, 16284.0, 669.4945316286197, 806.8305655812272, 825.7192554531458, 825.9215374539439, 826.6941231744263, 788.1606089514648, 807.4307613132727, 807.4993504027511, 807.7132617920641, 814.1410811593767, 852.1904191018526, 852.595017366752, 853.4196746212573, 854.2738672128703, 854.4702284583567, 692.4287462843174, 848.9575521223945, 850.4132148817328, 850.7617866997251, 852.8678054901469, 601.3355242457066, 617.2315467243266, 618.3723520626568, 618.4526693875907, 625.524601303013, 15671.451499197474, 15673.216339182994, 15688.529344119695, 15707.293171807296, 15718.292676829456, 13642.863571364358, 14178.929105354511, 14410.92794536031, 14469.49356772508, 14566.198859062748, 13320.93339533296, 13404.530841420601, 13409.731805363936, 13589.252591107484, 13715.0, 4458.509563947963, 4472.127935052666, 4492.146492166478, 4543.727376357396, 4576.0161565263625, 80927.59536202281, 84126.15873841244, 85085.14914850834, 85418.57290713569, 85860.0, 10145.391276523285, 10343.120834728981, 10479.528421221063, 10509.684709458728, 10700.625478108228, 20514.692279615818, 20656.690149647766, 20711.792882071288, 20835.58328833415, 21246.893765531382, 7431.0, 7475.775726728207, 7638.121616014118, 7684.346830519356, 8214.4660597061, 4385.188740083095, 4479.126570318756, 4533.274676051816, 4544.409226800495, 4595.103954728863, 3461.913452163716, 3613.4941108244866, 3613.6928361089604, 3616.620254873253, 3617.366960781853, 617.3425302053299, 632.6994677528229, 637.2512298049772, 637.7225906730587, 653.4184575727606, 682.2086379799409, 682.754208484945, 727.5889122645689, 761.6306091545596, 787.6731156570074, 9045.638174473079, 9226.76933076665, 9592.95203523978, 10166.847497287547, 10286.0, 617.2777849915609, 647.2847503508556, 675.5237557521936, 683.596677960006, 770.3221165374434, 4638.536146385334, 5059.544640982329, 5069.797208111708, 5093.18509038552, 5149.459306772735, 66632.0, 67060.6646966762, 68730.31269687338, 68898.0, 122163.38918305529, 99130.0, 102419.48790256001, 102796.48601756943, 102985.0, 103037.0, 83588.0, 84126.15873841305, 88922.55538722264, 89886.0, 91721.0, 9661.082197191256, 10244.846327304947, 10388.636397726043, 10460.68617941463, 10701.250912436055, 50374.0, 51474.227886580986, 51747.482525174266, 52349.738251310024, 53451.46548534465, 68294.0, 71667.64166179136, 76545.0, 77458.0, 79515.2048479531, 12419.0, 12704.428300726304, 12709.491620335082, 12717.173383730027, 13310.933445332712, 14987.475438360041, 15173.165475898932, 15479.0, 15545.533633990999, 16115.838841611903, 14167.504137355143, 14399.78400323975, 14457.27713614336, 14644.414223430944, 15612.141332226836, 13869.167849929037, 13959.581212563638, 14422.495212667925, 14798.260086995822, 14873.92563037178, 13348.866511334762, 13581.93209033988, 13959.441622334993, 14136.929315353358, 14410.135391876522, 11572.768544628892, 11981.64055078349, 11987.940060299643, 12401.535447238806, 12808.103432759617, 12117.15179937396, 12374.195677280948, 12382.504699811907, 12528.436220369922, 12582.685432864251], "value": 7634.570134586676, "unit": "score"}], "name": "dromaeo_css", "value": 7227.323887419869, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 118.0, 113.0, 114.0, 114.0, 111.0, 112.0, 112.0, 129.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 145.0, 175.0, 119.0, 144.0, 147.0, 118.0, 172.0, 117.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 162.0, 164.0, 163.0, 164.0, 161.0, 165.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 171.0, 78.0, 77.0, 76.0, 76.0, 159.0, 75.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 140.0, 83.0, 83.0, 84.0, 149.0, 83.0, 83.0, 143.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 118.0, 117.0, 119.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 53.0, 54.0, 53.0, 55.0, 53.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 62.0, 61.0, 61.0, 61.0, 62.0, 62.0, 64.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 82.0, 80.0, 78.0, 79.0, 80.0, 78.0, 89.0, 79.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 125.0, 137.0, 129.0, 139.0, 126.0, 134.0, 126.0, 183.0, 137.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 167.0, 169.0, 170.0, 166.0, 166.0, 164.0, 169.0, 164.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 66.0, 67.0, 66.0, 69.0, 66.0, 74.0, 66.0, 66.0, 65.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1540.0000000000002, "alertThreshold": 2.0}]} 16:31:01 INFO - Return code: 0 16:31:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:31:01 INFO - # TBPL SUCCESS # 16:31:01 INFO - Running post-action listener: _resource_record_post_action 16:31:01 INFO - [mozharness: 2016-09-02 23:31:01.976988Z] Finished run-tests step (success) 16:31:01 INFO - Running post-run listener: _resource_record_post_run 16:31:02 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 419233792; Read time: 104; Write time: 377568 16:31:02 INFO - TinderboxPrint: CPU usage
13.1% 16:31:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 104 16:31:02 INFO - TinderboxPrint: I/O write bytes / time
419,233,792 / 377,568 16:31:02 INFO - TinderboxPrint: CPU idle
8,279.7 (86.9%) 16:31:02 INFO - TinderboxPrint: CPU user
1,196.1 (12.6%) 16:31:02 INFO - TinderboxPrint: Swap in / out
0 / 0 16:31:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 128770048; Read time: 0; Write time: 110388 16:31:02 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289574912; Read time: 104; Write time: 267152 16:31:02 INFO - Running post-run listener: _upload_blobber_files 16:31:02 INFO - Blob upload gear active. 16:31:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:31:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:31:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:31:03 INFO - (blobuploader) - INFO - Open directory for files ... 16:31:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:31:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:31:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:06 INFO - (blobuploader) - INFO - Done attempting. 16:31:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:31:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:31:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:08 INFO - (blobuploader) - INFO - Done attempting. 16:31:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:31:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:31:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:08 INFO - (blobuploader) - INFO - Done attempting. 16:31:08 INFO - (blobuploader) - INFO - Iteration through files over. 16:31:08 INFO - Return code: 0 16:31:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:31:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:31:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90d4c8d1c4abe1c0fcb41866e1dc1390cbb4eea1e9112880ab0b1968cdad63a9951ea7116cd0d55b02fac42a6c097e27914f4118766002de8e3ab05d8f269b46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa7c8c5a9434cde4ced3c8a01dfc8711ae9901320129896950e29451f954c9dc2b85ad2adb36877e219378287371d199b177abf992508d5eee817d23dce41d4e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b41d8c6e77054a518d869f213c254385998edc990141f2218a89692b91cd20aa8fd5c6b5659232f54fe3c229741399a76fe6e40185e523d3716c1df7eaa993c7"} 16:31:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:31:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:31:08 INFO - Contents: 16:31:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90d4c8d1c4abe1c0fcb41866e1dc1390cbb4eea1e9112880ab0b1968cdad63a9951ea7116cd0d55b02fac42a6c097e27914f4118766002de8e3ab05d8f269b46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa7c8c5a9434cde4ced3c8a01dfc8711ae9901320129896950e29451f954c9dc2b85ad2adb36877e219378287371d199b177abf992508d5eee817d23dce41d4e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b41d8c6e77054a518d869f213c254385998edc990141f2218a89692b91cd20aa8fd5c6b5659232f54fe3c229741399a76fe6e40185e523d3716c1df7eaa993c7"} 16:31:08 INFO - Running post-run listener: copy_logs_to_upload_dir 16:31:08 INFO - Copying logs to upload dir... 16:31:08 INFO - mkdir: /builds/slave/test/build/upload/logs 16:31:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.966826 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-09-02 16:31:07.666121) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 16:31:07.674104) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90d4c8d1c4abe1c0fcb41866e1dc1390cbb4eea1e9112880ab0b1968cdad63a9951ea7116cd0d55b02fac42a6c097e27914f4118766002de8e3ab05d8f269b46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa7c8c5a9434cde4ced3c8a01dfc8711ae9901320129896950e29451f954c9dc2b85ad2adb36877e219378287371d199b177abf992508d5eee817d23dce41d4e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b41d8c6e77054a518d869f213c254385998edc990141f2218a89692b91cd20aa8fd5c6b5659232f54fe3c229741399a76fe6e40185e523d3716c1df7eaa993c7"} build_url:https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011253 build_url: 'https://queue.taskcluster.net/v1/task/FqrVgDuxTeOsUIT9oLVHxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90d4c8d1c4abe1c0fcb41866e1dc1390cbb4eea1e9112880ab0b1968cdad63a9951ea7116cd0d55b02fac42a6c097e27914f4118766002de8e3ab05d8f269b46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa7c8c5a9434cde4ced3c8a01dfc8711ae9901320129896950e29451f954c9dc2b85ad2adb36877e219378287371d199b177abf992508d5eee817d23dce41d4e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b41d8c6e77054a518d869f213c254385998edc990141f2218a89692b91cd20aa8fd5c6b5659232f54fe3c229741399a76fe6e40185e523d3716c1df7eaa993c7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 16:31:07.702160) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 16:31:07.702596) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1472857243.360409-1093034366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 16:31:07.784485) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 16:31:07.787879) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 16:31:07.788212) ========= ========= Total master_lag: 0.23 =========